builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-063 starttime: 1448290394.79 results: success (0) buildid: 20151123043002 builduid: e3df8d49af62420fa3b191818a6ad8b8 revision: 8b1fc0961a076e35646d0472a81feefc0074558c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 06:53:14.787225) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 06:53:14.787616) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 06:53:14.787890) ========= 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=edca6ca23558fe0608d91a4e00000196-1448290337.102161-1359648957 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006573 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 06:53:14.805534) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 06:53:14.805807) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 06:53:14.814554) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 06:53:14.814823) ========= 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=edca6ca23558fe0608d91a4e00000196-1448290337.102161-1359648957 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004093 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 06:53:14.862627) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 06:53:14.862960) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 06:53:14.863331) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 06:53:14.863594) ========= 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=edca6ca23558fe0608d91a4e00000196-1448290337.102161-1359648957 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-23 06:53:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 47.1M=0s 2015-11-23 06:53:16 (47.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.187571 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 06:53:15.062815) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 06:53:15.063124) ========= 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=edca6ca23558fe0608d91a4e00000196-1448290337.102161-1359648957 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017236 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 06:53:15.113739) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 06:53:15.114251) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8b1fc0961a076e35646d0472a81feefc0074558c --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 8b1fc0961a076e35646d0472a81feefc0074558c --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=edca6ca23558fe0608d91a4e00000196-1448290337.102161-1359648957 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-23 06:53:17,078 truncating revision to first 12 chars 2015-11-23 06:53:17,079 Setting DEBUG logging. 2015-11-23 06:53:17,079 attempt 1/10 2015-11-23 06:53:17,079 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8b1fc0961a07?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-23 06:53:17,326 unpacking tar archive at: mozilla-central-8b1fc0961a07/testing/mozharness/ program finished with exit code 0 elapsedTime=0.520313 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 06:53:15.648083) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 06:53:15.648401) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 06:53:15.657683) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 06:53:15.658040) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 06:53:15.658530) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2015-11-23 06:53:15.658805) ========= /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=edca6ca23558fe0608d91a4e00000196-1448290337.102161-1359648957 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:53:17 INFO - MultiFileLogger online at 20151123 06:53:17 in /builds/slave/test-pgo 06:53:17 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 06:53:17 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 06:53:17 INFO - {'append_to_log': False, 06:53:17 INFO - 'base_work_dir': '/builds/slave/test-pgo', 06:53:17 INFO - 'blob_upload_branch': 'Firefox', 06:53:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 06:53:17 INFO - 'branch': 'Firefox', 06:53:17 INFO - 'buildbot_json_path': 'buildprops.json', 06:53:17 INFO - 'config_files': ('talos/linux_config.py',), 06:53:17 INFO - 'default_actions': ('clobber', 06:53:17 INFO - 'read-buildbot-config', 06:53:17 INFO - 'download-and-extract', 06:53:17 INFO - 'populate-webroot', 06:53:17 INFO - 'create-virtualenv', 06:53:17 INFO - 'install', 06:53:17 INFO - 'run-tests'), 06:53:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:53:17 INFO - 'download_minidump_stackwalk': True, 06:53:17 INFO - 'download_symbols': 'ondemand', 06:53:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:53:17 INFO - 'tooltool.py': '/tools/tooltool.py', 06:53:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:53:17 INFO - '/tools/misc-python/virtualenv.py')}, 06:53:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:53:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:53:17 INFO - 'installer_path': 'installer.exe', 06:53:17 INFO - 'log_level': 'info', 06:53:17 INFO - 'log_name': 'talos', 06:53:17 INFO - 'log_to_console': True, 06:53:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:53:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:53:17 INFO - 'opt_config_files': (), 06:53:17 INFO - 'pip_index': False, 06:53:17 INFO - 'sps_profile': False, 06:53:17 INFO - 'sps_profile_interval': 0, 06:53:17 INFO - 'suite': 'dromaeojs', 06:53:17 INFO - 'system_bits': '64', 06:53:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:53:17 INFO - 'title': 'talos-linux64-ix-063', 06:53:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:53:17 INFO - 'use_talos_json': True, 06:53:17 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 06:53:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:53:17 INFO - 'work_dir': 'build'} 06:53:17 INFO - ##### 06:53:17 INFO - ##### Running clobber step. 06:53:17 INFO - ##### 06:53:17 INFO - Running pre-action listener: _resource_record_pre_action 06:53:17 INFO - Running main action method: clobber 06:53:17 INFO - rmtree: /builds/slave/test-pgo/build 06:53:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 06:53:18 INFO - Running post-action listener: _resource_record_post_action 06:53:18 INFO - ##### 06:53:18 INFO - ##### Running read-buildbot-config step. 06:53:18 INFO - ##### 06:53:18 INFO - Running pre-action listener: _resource_record_pre_action 06:53:18 INFO - Running main action method: read_buildbot_config 06:53:18 INFO - Using buildbot properties: 06:53:18 INFO - { 06:53:18 INFO - "properties": { 06:53:18 INFO - "buildnumber": 266, 06:53:18 INFO - "product": "firefox", 06:53:18 INFO - "script_repo_revision": "production", 06:53:18 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 06:53:18 INFO - "repository": "", 06:53:18 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 06:53:18 INFO - "buildid": "20151123043002", 06:53:18 INFO - "slavename": "talos-linux64-ix-063", 06:53:18 INFO - "pgo_build": "True", 06:53:18 INFO - "basedir": "/builds/slave/test-pgo", 06:53:18 INFO - "project": "", 06:53:18 INFO - "platform": "ubuntu64_hw", 06:53:18 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:53:18 INFO - "slavebuilddir": "test", 06:53:18 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 06:53:18 INFO - "branch": "mozilla-central", 06:53:18 INFO - "repo_path": "mozilla-central", 06:53:18 INFO - "stage_platform": "linux64-pgo", 06:53:18 INFO - "builduid": "e3df8d49af62420fa3b191818a6ad8b8", 06:53:18 INFO - "revision": "8b1fc0961a076e35646d0472a81feefc0074558c" 06:53:18 INFO - }, 06:53:18 INFO - "sourcestamp": { 06:53:18 INFO - "repository": "", 06:53:18 INFO - "hasPatch": false, 06:53:18 INFO - "project": "", 06:53:18 INFO - "branch": "mozilla-central-linux64-pgo-talos", 06:53:18 INFO - "changes": [ 06:53:18 INFO - { 06:53:18 INFO - "category": null, 06:53:18 INFO - "files": [ 06:53:18 INFO - { 06:53:18 INFO - "url": null, 06:53:18 INFO - "name": "https://queue.taskcluster.net/v1/task/tN1Vpl1qTAWhMzTte2gNJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 06:53:18 INFO - } 06:53:18 INFO - ], 06:53:18 INFO - "repository": "", 06:53:18 INFO - "rev": "8b1fc0961a076e35646d0472a81feefc0074558c", 06:53:18 INFO - "who": "sendchange", 06:53:18 INFO - "when": 1448290335, 06:53:18 INFO - "number": 6695063, 06:53:18 INFO - "comments": "", 06:53:18 INFO - "project": "", 06:53:18 INFO - "at": "Mon 23 Nov 2015 06:52:15", 06:53:18 INFO - "branch": "mozilla-central-linux64-pgo-talos", 06:53:18 INFO - "revlink": "", 06:53:18 INFO - "properties": [ 06:53:18 INFO - [ 06:53:18 INFO - "buildid", 06:53:18 INFO - "20151123043002", 06:53:18 INFO - "Change" 06:53:18 INFO - ], 06:53:18 INFO - [ 06:53:18 INFO - "builduid", 06:53:18 INFO - "e3df8d49af62420fa3b191818a6ad8b8", 06:53:18 INFO - "Change" 06:53:18 INFO - ], 06:53:18 INFO - [ 06:53:18 INFO - "pgo_build", 06:53:18 INFO - "True", 06:53:18 INFO - "Change" 06:53:18 INFO - ] 06:53:18 INFO - ], 06:53:18 INFO - "revision": "8b1fc0961a076e35646d0472a81feefc0074558c" 06:53:18 INFO - } 06:53:18 INFO - ], 06:53:18 INFO - "revision": "8b1fc0961a076e35646d0472a81feefc0074558c" 06:53:18 INFO - } 06:53:18 INFO - } 06:53:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/tN1Vpl1qTAWhMzTte2gNJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 06:53:18 INFO - Running post-action listener: _resource_record_post_action 06:53:18 INFO - ##### 06:53:18 INFO - ##### Running download-and-extract step. 06:53:18 INFO - ##### 06:53:18 INFO - Running pre-action listener: _resource_record_pre_action 06:53:18 INFO - Running main action method: download_and_extract 06:53:18 INFO - mkdir: /builds/slave/test-pgo/build/tests 06:53:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:53:18 INFO - https://queue.taskcluster.net/v1/task/tN1Vpl1qTAWhMzTte2gNJQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 06:53:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tN1Vpl1qTAWhMzTte2gNJQ/artifacts/public/build/test_packages.json 06:53:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tN1Vpl1qTAWhMzTte2gNJQ/artifacts/public/build/test_packages.json 06:53:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tN1Vpl1qTAWhMzTte2gNJQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 06:53:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tN1Vpl1qTAWhMzTte2gNJQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 06:53:18 INFO - Downloaded 1302 bytes. 06:53:18 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 06:53:18 INFO - Using the following test package requirements: 06:53:18 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 06:53:18 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:53:18 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:53:18 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:53:18 INFO - u'jsshell-linux-x86_64.zip'], 06:53:18 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:53:18 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:53:18 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 06:53:18 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:53:18 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:53:18 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:53:18 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:53:18 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:53:18 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:53:18 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 06:53:18 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:53:18 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:53:18 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:53:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:53:18 INFO - https://queue.taskcluster.net/v1/task/tN1Vpl1qTAWhMzTte2gNJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:53:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tN1Vpl1qTAWhMzTte2gNJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:53:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tN1Vpl1qTAWhMzTte2gNJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:53:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tN1Vpl1qTAWhMzTte2gNJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:53:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tN1Vpl1qTAWhMzTte2gNJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:53:19 INFO - Downloaded 22524477 bytes. 06:53:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 06:53:19 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:53:19 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 06:53:20 INFO - Return code: 0 06:53:20 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:53:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:53:20 INFO - https://queue.taskcluster.net/v1/task/tN1Vpl1qTAWhMzTte2gNJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:53:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tN1Vpl1qTAWhMzTte2gNJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:53:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tN1Vpl1qTAWhMzTte2gNJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:53:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tN1Vpl1qTAWhMzTte2gNJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:53:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tN1Vpl1qTAWhMzTte2gNJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:53:22 INFO - Downloaded 22524477 bytes. 06:53:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 06:53:22 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:53:22 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 06:53:23 INFO - Return code: 0 06:53:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:53:23 INFO - https://queue.taskcluster.net/v1/task/tN1Vpl1qTAWhMzTte2gNJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:53:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tN1Vpl1qTAWhMzTte2gNJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 06:53:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tN1Vpl1qTAWhMzTte2gNJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 06:53:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tN1Vpl1qTAWhMzTte2gNJQ/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 06:53:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tN1Vpl1qTAWhMzTte2gNJQ/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 06:53:24 INFO - Downloaded 11130997 bytes. 06:53:24 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 06:53:24 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 06:53:24 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 06:53:24 INFO - Return code: 0 06:53:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:53:24 INFO - https://queue.taskcluster.net/v1/task/tN1Vpl1qTAWhMzTte2gNJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:53:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tN1Vpl1qTAWhMzTte2gNJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:53:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tN1Vpl1qTAWhMzTte2gNJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:53:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tN1Vpl1qTAWhMzTte2gNJQ/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 06:53:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tN1Vpl1qTAWhMzTte2gNJQ/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 06:53:25 INFO - Downloaded 57450217 bytes. 06:53:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/tN1Vpl1qTAWhMzTte2gNJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:53:25 INFO - mkdir: /builds/slave/test-pgo/properties 06:53:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 06:53:25 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 06:53:25 INFO - Contents: 06:53:25 INFO - build_url:https://queue.taskcluster.net/v1/task/tN1Vpl1qTAWhMzTte2gNJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:53:25 INFO - Running post-action listener: _resource_record_post_action 06:53:25 INFO - Running post-action listener: set_extra_try_arguments 06:53:25 INFO - ##### 06:53:25 INFO - ##### Running populate-webroot step. 06:53:25 INFO - ##### 06:53:25 INFO - Running pre-action listener: _resource_record_pre_action 06:53:25 INFO - Running main action method: populate_webroot 06:53:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:53:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:53:25 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 06:53:25 INFO - '../fennec_ids.txt'], 06:53:25 INFO - 'tests': ['tcheck2']}, 06:53:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:53:25 INFO - '--tppagecycles', 06:53:25 INFO - '7'], 06:53:25 INFO - 'tests': ['tsvgm']}}, 06:53:25 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:53:25 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:53:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:53:25 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:53:25 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:53:25 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:53:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:53:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:53:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:53:25 INFO - 'talos_options': ['--e10s'], 06:53:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:53:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:53:25 INFO - 'tests': ['damp', 'tps']}, 06:53:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:53:25 INFO - 'talos_options': ['--e10s'], 06:53:25 INFO - 'tests': ['damp', 'tps']}, 06:53:25 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:53:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:53:25 INFO - 'other': {'tests': ['a11yr', 06:53:25 INFO - 'ts_paint', 06:53:25 INFO - 'tpaint', 06:53:25 INFO - 'sessionrestore', 06:53:25 INFO - 'sessionrestore_no_auto_restore']}, 06:53:25 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:53:25 INFO - 'tests': ['a11yr', 06:53:25 INFO - 'ts_paint', 06:53:25 INFO - 'tpaint', 06:53:25 INFO - 'sessionrestore', 06:53:25 INFO - 'sessionrestore_no_auto_restore']}, 06:53:25 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:53:25 INFO - 'tests': ['a11yr', 06:53:25 INFO - 'ts_paint', 06:53:25 INFO - 'tpaint', 06:53:25 INFO - 'sessionrestore', 06:53:25 INFO - 'sessionrestore_no_auto_restore']}, 06:53:25 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:53:25 INFO - 'tests': ['a11yr', 06:53:25 INFO - 'ts_paint', 06:53:25 INFO - 'tpaint', 06:53:25 INFO - 'sessionrestore', 06:53:25 INFO - 'sessionrestore_no_auto_restore']}, 06:53:25 INFO - 'other_l64': {'tests': ['a11yr', 06:53:25 INFO - 'ts_paint', 06:53:25 INFO - 'tpaint', 06:53:25 INFO - 'sessionrestore', 06:53:25 INFO - 'sessionrestore_no_auto_restore']}, 06:53:25 INFO - 'other_nol64': {'tests': ['a11yr', 06:53:25 INFO - 'ts_paint', 06:53:25 INFO - 'tpaint', 06:53:25 INFO - 'sessionrestore', 06:53:25 INFO - 'sessionrestore_no_auto_restore']}, 06:53:25 INFO - 'svgr': {'tests': ['tsvgx', 06:53:25 INFO - 'tsvgr_opacity', 06:53:25 INFO - 'tart', 06:53:25 INFO - 'tscrollx', 06:53:25 INFO - 'cart']}, 06:53:25 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:53:25 INFO - 'tests': ['tsvgx', 06:53:25 INFO - 'tsvgr_opacity', 06:53:25 INFO - 'tart', 06:53:25 INFO - 'tscrollx', 06:53:25 INFO - 'cart']}, 06:53:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:53:25 INFO - 'tests': ['tp5o']}, 06:53:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:53:25 INFO - 'talos_options': ['--e10s'], 06:53:25 INFO - 'tests': ['tp5o']}, 06:53:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:53:25 INFO - 'talos_options': ['--xperf_path', 06:53:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:53:25 INFO - 'tests': ['tp5n']}, 06:53:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:53:25 INFO - 'talos_options': ['--e10s', 06:53:25 INFO - '--xperf_path', 06:53:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:53:25 INFO - 'tests': ['tp5n']}}, 06:53:25 INFO - 'talos.zip': {'path': '', 06:53:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:53:25 INFO - Running post-action listener: _resource_record_post_action 06:53:25 INFO - ##### 06:53:25 INFO - ##### Running create-virtualenv step. 06:53:25 INFO - ##### 06:53:25 INFO - Running pre-action listener: _resource_record_pre_action 06:53:25 INFO - Running main action method: create_virtualenv 06:53:25 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 06:53:25 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 06:53:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 06:53:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:53:25 INFO - Using real prefix '/usr' 06:53:25 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 06:53:26 INFO - Installing distribute.............................................................................................................................................................................................done. 06:53:28 INFO - Installing pip.................done. 06:53:28 INFO - Return code: 0 06:53:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 06:53:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:53:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:53:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:53:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:53:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:53:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:53:28 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 0x7f791e4eec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21726c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22336e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2269a90>, '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 0x22bbf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22bc2e0>, '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': 'edca6ca23558fe0608d91a4e00000196-1448290337.102161-1359648957', '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 06:53:28 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 06:53:28 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 06:53:28 INFO - Using env: {'DISPLAY': ':0', 06:53:28 INFO - 'HOME': '/home/cltbld', 06:53:28 INFO - 'LANG': 'en_US.UTF-8', 06:53:28 INFO - 'LANGUAGE': 'en_US:en', 06:53:28 INFO - 'LOGNAME': 'cltbld', 06:53:28 INFO - 'MAIL': '/var/mail/cltbld', 06:53:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:53:28 INFO - 'MOZ_NO_REMOTE': '1', 06:53:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:53:28 INFO - 'NO_EM_RESTART': '1', 06:53:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:53:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:53:28 INFO - 'PWD': '/builds/slave/test-pgo', 06:53:28 INFO - 'SHELL': '/bin/bash', 06:53:28 INFO - 'SHLVL': '1', 06:53:28 INFO - 'TERM': 'linux', 06:53:28 INFO - 'TMOUT': '86400', 06:53:28 INFO - 'USER': 'cltbld', 06:53:28 INFO - 'XDG_SESSION_COOKIE': 'edca6ca23558fe0608d91a4e00000196-1448290337.102161-1359648957', 06:53:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:53:28 INFO - '_': '/tools/buildbot/bin/python'} 06:53:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:53:28 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 06:53:28 INFO - Cleaning up... 06:53:28 INFO - Return code: 0 06:53:28 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 06:53:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:53:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:53:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:53:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:53:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:53:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:53:28 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 0x7f791e4eec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21726c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22336e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2269a90>, '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 0x22bbf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22bc2e0>, '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': 'edca6ca23558fe0608d91a4e00000196-1448290337.102161-1359648957', '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 06:53:28 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 06:53:28 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 06:53:28 INFO - Using env: {'DISPLAY': ':0', 06:53:28 INFO - 'HOME': '/home/cltbld', 06:53:28 INFO - 'LANG': 'en_US.UTF-8', 06:53:28 INFO - 'LANGUAGE': 'en_US:en', 06:53:28 INFO - 'LOGNAME': 'cltbld', 06:53:28 INFO - 'MAIL': '/var/mail/cltbld', 06:53:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:53:28 INFO - 'MOZ_NO_REMOTE': '1', 06:53:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:53:28 INFO - 'NO_EM_RESTART': '1', 06:53:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:53:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:53:28 INFO - 'PWD': '/builds/slave/test-pgo', 06:53:28 INFO - 'SHELL': '/bin/bash', 06:53:28 INFO - 'SHLVL': '1', 06:53:28 INFO - 'TERM': 'linux', 06:53:28 INFO - 'TMOUT': '86400', 06:53:28 INFO - 'USER': 'cltbld', 06:53:28 INFO - 'XDG_SESSION_COOKIE': 'edca6ca23558fe0608d91a4e00000196-1448290337.102161-1359648957', 06:53:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:53:28 INFO - '_': '/tools/buildbot/bin/python'} 06:53:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:53:28 INFO - Downloading/unpacking psutil>=0.7.1 06:53:28 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 06:53:28 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 06:53:28 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 06:53:28 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 06:53:28 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 06:53:28 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 06:53:30 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 06:53:30 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 06:53:30 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 06:53:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:53:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:53:30 INFO - Installing collected packages: psutil 06:53:30 INFO - Running setup.py install for psutil 06:53:30 INFO - building 'psutil._psutil_linux' extension 06:53:30 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 06:53:30 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 06:53:30 INFO - building 'psutil._psutil_posix' extension 06:53:30 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 06:53:31 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 06:53:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:53:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:53:31 INFO - Successfully installed psutil 06:53:31 INFO - Cleaning up... 06:53:31 INFO - Return code: 0 06:53:31 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 06: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')]} 06:53:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:53:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06: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')]} 06:53:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:53:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:53:31 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 0x7f791e4eec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21726c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22336e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2269a90>, '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 0x22bbf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22bc2e0>, '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': 'edca6ca23558fe0608d91a4e00000196-1448290337.102161-1359648957', '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 06:53:31 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 06:53:31 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 06:53:31 INFO - Using env: {'DISPLAY': ':0', 06:53:31 INFO - 'HOME': '/home/cltbld', 06:53:31 INFO - 'LANG': 'en_US.UTF-8', 06:53:31 INFO - 'LANGUAGE': 'en_US:en', 06:53:31 INFO - 'LOGNAME': 'cltbld', 06:53:31 INFO - 'MAIL': '/var/mail/cltbld', 06:53:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:53:31 INFO - 'MOZ_NO_REMOTE': '1', 06:53:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:53:31 INFO - 'NO_EM_RESTART': '1', 06:53:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:53:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:53:31 INFO - 'PWD': '/builds/slave/test-pgo', 06:53:31 INFO - 'SHELL': '/bin/bash', 06:53:31 INFO - 'SHLVL': '1', 06:53:31 INFO - 'TERM': 'linux', 06:53:31 INFO - 'TMOUT': '86400', 06:53:31 INFO - 'USER': 'cltbld', 06:53:31 INFO - 'XDG_SESSION_COOKIE': 'edca6ca23558fe0608d91a4e00000196-1448290337.102161-1359648957', 06:53:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:53:31 INFO - '_': '/tools/buildbot/bin/python'} 06:53:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:53:31 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:53:31 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 06:53:31 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 06:53:31 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 06:53:31 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 06:53:31 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 06:53:31 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 06:53:33 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:53:33 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 06:53:33 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:53:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:53:33 INFO - Installing collected packages: mozsystemmonitor 06:53:33 INFO - Running setup.py install for mozsystemmonitor 06:53:33 INFO - Successfully installed mozsystemmonitor 06:53:33 INFO - Cleaning up... 06:53:33 INFO - Return code: 0 06:53:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 06:53:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:53:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:53:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:53:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:53:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:53:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:53:33 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 0x7f791e4eec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21726c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22336e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2269a90>, '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 0x22bbf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22bc2e0>, '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': 'edca6ca23558fe0608d91a4e00000196-1448290337.102161-1359648957', '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 06:53:33 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 06:53:33 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 06:53:33 INFO - Using env: {'DISPLAY': ':0', 06:53:33 INFO - 'HOME': '/home/cltbld', 06:53:33 INFO - 'LANG': 'en_US.UTF-8', 06:53:33 INFO - 'LANGUAGE': 'en_US:en', 06:53:33 INFO - 'LOGNAME': 'cltbld', 06:53:33 INFO - 'MAIL': '/var/mail/cltbld', 06:53:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:53:33 INFO - 'MOZ_NO_REMOTE': '1', 06:53:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:53:33 INFO - 'NO_EM_RESTART': '1', 06:53:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:53:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:53:33 INFO - 'PWD': '/builds/slave/test-pgo', 06:53:33 INFO - 'SHELL': '/bin/bash', 06:53:33 INFO - 'SHLVL': '1', 06:53:33 INFO - 'TERM': 'linux', 06:53:33 INFO - 'TMOUT': '86400', 06:53:33 INFO - 'USER': 'cltbld', 06:53:33 INFO - 'XDG_SESSION_COOKIE': 'edca6ca23558fe0608d91a4e00000196-1448290337.102161-1359648957', 06:53:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:53:33 INFO - '_': '/tools/buildbot/bin/python'} 06:53:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:53:33 INFO - Downloading/unpacking blobuploader==1.2.4 06:53:33 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 06:53:33 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 06:53:33 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 06:53:33 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 06:53:33 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 06:53:33 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 06:53:35 INFO - Downloading blobuploader-1.2.4.tar.gz 06:53:35 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 06:53:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:53:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:53:35 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 06:53:35 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 06:53:35 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 06:53:35 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 06:53:35 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 06:53:35 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 06:53:35 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 06:53:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 06:53:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:53:35 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 06:53:35 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 06:53:35 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 06:53:35 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 06:53:35 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 06:53:35 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 06:53:35 INFO - Downloading docopt-0.6.1.tar.gz 06:53:35 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 06:53:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 06:53:35 INFO - Installing collected packages: blobuploader, requests, docopt 06:53:35 INFO - Running setup.py install for blobuploader 06:53:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:53:35 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 06:53:36 INFO - Running setup.py install for requests 06:53:36 INFO - Running setup.py install for docopt 06:53:36 INFO - Successfully installed blobuploader requests docopt 06:53:36 INFO - Cleaning up... 06:53:36 INFO - Return code: 0 06:53:36 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:53:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:53:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:53:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:53:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:53:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:53:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:53:36 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 0x7f791e4eec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21726c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22336e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2269a90>, '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 0x22bbf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22bc2e0>, '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': 'edca6ca23558fe0608d91a4e00000196-1448290337.102161-1359648957', '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 06:53:36 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 06:53:36 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 06:53:36 INFO - Using env: {'DISPLAY': ':0', 06:53:36 INFO - 'HOME': '/home/cltbld', 06:53:36 INFO - 'LANG': 'en_US.UTF-8', 06:53:36 INFO - 'LANGUAGE': 'en_US:en', 06:53:36 INFO - 'LOGNAME': 'cltbld', 06:53:36 INFO - 'MAIL': '/var/mail/cltbld', 06:53:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:53:36 INFO - 'MOZ_NO_REMOTE': '1', 06:53:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:53:36 INFO - 'NO_EM_RESTART': '1', 06:53:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:53:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:53:36 INFO - 'PWD': '/builds/slave/test-pgo', 06:53:36 INFO - 'SHELL': '/bin/bash', 06:53:36 INFO - 'SHLVL': '1', 06:53:36 INFO - 'TERM': 'linux', 06:53:36 INFO - 'TMOUT': '86400', 06:53:36 INFO - 'USER': 'cltbld', 06:53:36 INFO - 'XDG_SESSION_COOKIE': 'edca6ca23558fe0608d91a4e00000196-1448290337.102161-1359648957', 06:53:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:53:36 INFO - '_': '/tools/buildbot/bin/python'} 06:53:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:53:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:53:36 INFO - Running setup.py (path:/tmp/pip-cgW0PQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:53:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:53:36 INFO - Running setup.py (path:/tmp/pip-biZ6N3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:53:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:53:36 INFO - Running setup.py (path:/tmp/pip-6cR51u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:53:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:53:36 INFO - Running setup.py (path:/tmp/pip-P25CKf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:53:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 06:53:37 INFO - Running setup.py (path:/tmp/pip-BSJk7K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 06:53:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:53:37 INFO - Running setup.py (path:/tmp/pip-xxmtwv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:53:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:53:37 INFO - Running setup.py (path:/tmp/pip-rcsvYT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:53:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:53:37 INFO - Running setup.py (path:/tmp/pip-rZDyUi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:53:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 06:53:37 INFO - Running setup.py (path:/tmp/pip-n_VQ7m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 06:53:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 06:53:37 INFO - Running setup.py (path:/tmp/pip-lzHIci-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 06:53:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:53:37 INFO - Running setup.py (path:/tmp/pip-o8MjTY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:53:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:53:37 INFO - Running setup.py (path:/tmp/pip-5fuRim-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:53:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:53:37 INFO - Running setup.py (path:/tmp/pip-TA7KgQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:53:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:53:37 INFO - Running setup.py (path:/tmp/pip-NyQZp4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:53:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:53:37 INFO - Running setup.py (path:/tmp/pip-RIuUbg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:53:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 06:53:37 INFO - Running setup.py (path:/tmp/pip-A6xufg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 06:53:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 06:53:37 INFO - Running setup.py (path:/tmp/pip-8efssf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 06:53:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:53:37 INFO - Running setup.py install for manifestparser 06:53:38 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 06:53:38 INFO - Running setup.py install for mozcrash 06:53:38 INFO - Running setup.py install for mozdebug 06:53:38 INFO - Running setup.py install for mozdevice 06:53:38 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 06:53:38 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 06:53:38 INFO - Running setup.py install for mozfile 06:53:38 INFO - Running setup.py install for mozhttpd 06:53:38 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 06:53:38 INFO - Running setup.py install for mozinfo 06:53:38 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 06:53:38 INFO - Running setup.py install for mozInstall 06:53:38 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 06:53:38 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 06:53:38 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 06:53:38 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 06:53:38 INFO - Running setup.py install for mozleak 06:53:38 INFO - Running setup.py install for mozlog 06:53:38 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 06:53:38 INFO - Running setup.py install for moznetwork 06:53:39 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 06:53:39 INFO - Running setup.py install for mozprocess 06:53:39 INFO - Running setup.py install for mozprofile 06:53:39 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 06:53:39 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 06:53:39 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 06:53:39 INFO - Running setup.py install for mozrunner 06:53:39 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 06:53:39 INFO - Running setup.py install for mozscreenshot 06:53:39 INFO - Running setup.py install for moztest 06:53:39 INFO - Running setup.py install for mozversion 06:53:39 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 06:53:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:53:39 INFO - Cleaning up... 06:53:39 INFO - Return code: 0 06:53:39 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:53:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:53:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:53:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:53:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:53:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:53:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:53:39 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 0x7f791e4eec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21726c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22336e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2269a90>, '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 0x22bbf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22bc2e0>, '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': 'edca6ca23558fe0608d91a4e00000196-1448290337.102161-1359648957', '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 06:53:39 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 06:53:39 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 06:53:39 INFO - Using env: {'DISPLAY': ':0', 06:53:39 INFO - 'HOME': '/home/cltbld', 06:53:39 INFO - 'LANG': 'en_US.UTF-8', 06:53:39 INFO - 'LANGUAGE': 'en_US:en', 06:53:39 INFO - 'LOGNAME': 'cltbld', 06:53:39 INFO - 'MAIL': '/var/mail/cltbld', 06:53:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:53:39 INFO - 'MOZ_NO_REMOTE': '1', 06:53:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:53:39 INFO - 'NO_EM_RESTART': '1', 06:53:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:53:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:53:39 INFO - 'PWD': '/builds/slave/test-pgo', 06:53:39 INFO - 'SHELL': '/bin/bash', 06:53:39 INFO - 'SHLVL': '1', 06:53:39 INFO - 'TERM': 'linux', 06:53:39 INFO - 'TMOUT': '86400', 06:53:39 INFO - 'USER': 'cltbld', 06:53:39 INFO - 'XDG_SESSION_COOKIE': 'edca6ca23558fe0608d91a4e00000196-1448290337.102161-1359648957', 06:53:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:53:39 INFO - '_': '/tools/buildbot/bin/python'} 06:53:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:53:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:53:39 INFO - Running setup.py (path:/tmp/pip-5ZobY5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:53:39 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)) 06:53:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:53:39 INFO - Running setup.py (path:/tmp/pip-hT5WU_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:53:40 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)) 06:53:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:53:40 INFO - Running setup.py (path:/tmp/pip-5yUojE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:53:40 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)) 06:53:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:53:40 INFO - Running setup.py (path:/tmp/pip-7mMvV3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:53:40 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)) 06:53:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 06:53:40 INFO - Running setup.py (path:/tmp/pip-R8KMJM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 06:53:40 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)) 06:53:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:53:40 INFO - Running setup.py (path:/tmp/pip-DKcZoB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:53:40 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)) 06:53:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:53:40 INFO - Running setup.py (path:/tmp/pip-CsMR4L-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:53:40 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)) 06:53:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:53:40 INFO - Running setup.py (path:/tmp/pip-QwI67Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:53:40 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)) 06:53:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 06:53:40 INFO - Running setup.py (path:/tmp/pip-nPesNZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 06:53:40 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)) 06:53:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 06:53:40 INFO - Running setup.py (path:/tmp/pip-H3By8I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 06:53:40 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)) 06:53:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:53:40 INFO - Running setup.py (path:/tmp/pip-X7Cskc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:53:40 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)) 06:53:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:53:40 INFO - Running setup.py (path:/tmp/pip-rvayQK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:53:40 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)) 06:53:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:53:40 INFO - Running setup.py (path:/tmp/pip-P7qvLo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:53:40 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)) 06:53:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:53:40 INFO - Running setup.py (path:/tmp/pip-zUE8yG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:53:40 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)) 06:53:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:53:40 INFO - Running setup.py (path:/tmp/pip-EwN6Eq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:53:41 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)) 06:53:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 06:53:41 INFO - Running setup.py (path:/tmp/pip-a6buKk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 06:53:41 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)) 06:53:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 06:53:41 INFO - Running setup.py (path:/tmp/pip-1xCnNp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 06:53:41 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)) 06:53:41 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)) 06:53:41 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)) 06:53:41 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)) 06:53:41 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)) 06:53:41 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)) 06:53:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 06:53:41 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 06:53:41 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 06:53:41 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 06:53:41 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 06:53:41 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 06:53:41 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 06:53:42 INFO - Downloading blessings-1.5.1.tar.gz 06:53:42 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 06:53:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 06:53:42 INFO - Installing collected packages: blessings 06:53:42 INFO - Running setup.py install for blessings 06:53:43 INFO - Successfully installed blessings 06:53:43 INFO - Cleaning up... 06:53:43 INFO - Return code: 0 06:53:43 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 06:53:43 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 06:53:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 06:53:43 INFO - Reading from file tmpfile_stdout 06:53:43 INFO - Current package versions: 06:53:43 INFO - argparse == 1.2.1 06:53:43 INFO - blessings == 1.5.1 06:53:43 INFO - blobuploader == 1.2.4 06:53:43 INFO - docopt == 0.6.1 06:53:43 INFO - manifestparser == 1.1 06:53:43 INFO - mozInstall == 1.12 06:53:43 INFO - mozcrash == 0.16 06:53:43 INFO - mozdebug == 0.1 06:53:43 INFO - mozdevice == 0.47 06:53:43 INFO - mozfile == 1.2 06:53:43 INFO - mozhttpd == 0.7 06:53:43 INFO - mozinfo == 0.9 06:53:43 INFO - mozleak == 0.1 06:53:43 INFO - mozlog == 3.0 06:53:43 INFO - moznetwork == 0.27 06:53:43 INFO - mozprocess == 0.22 06:53:43 INFO - mozprofile == 0.27 06:53:43 INFO - mozrunner == 6.11 06:53:43 INFO - mozscreenshot == 0.1 06:53:43 INFO - mozsystemmonitor == 0.0 06:53:43 INFO - moztest == 0.7 06:53:43 INFO - mozversion == 1.4 06:53:43 INFO - psutil == 3.1.1 06:53:43 INFO - requests == 1.2.3 06:53:43 INFO - wsgiref == 0.1.2 06:53:43 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:53:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:53:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:53:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:53:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:53:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:53:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:53:43 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 0x7f791e4eec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21726c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22336e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2269a90>, '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 0x22bbf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22bc2e0>, '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': 'edca6ca23558fe0608d91a4e00000196-1448290337.102161-1359648957', '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 06:53:43 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 06:53:43 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 06:53:43 INFO - Using env: {'DISPLAY': ':0', 06:53:43 INFO - 'HOME': '/home/cltbld', 06:53:43 INFO - 'LANG': 'en_US.UTF-8', 06:53:43 INFO - 'LANGUAGE': 'en_US:en', 06:53:43 INFO - 'LOGNAME': 'cltbld', 06:53:43 INFO - 'MAIL': '/var/mail/cltbld', 06:53:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:53:43 INFO - 'MOZ_NO_REMOTE': '1', 06:53:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:53:43 INFO - 'NO_EM_RESTART': '1', 06:53:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:53:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:53:43 INFO - 'PWD': '/builds/slave/test-pgo', 06:53:43 INFO - 'SHELL': '/bin/bash', 06:53:43 INFO - 'SHLVL': '1', 06:53:43 INFO - 'TERM': 'linux', 06:53:43 INFO - 'TMOUT': '86400', 06:53:43 INFO - 'USER': 'cltbld', 06:53:43 INFO - 'XDG_SESSION_COOKIE': 'edca6ca23558fe0608d91a4e00000196-1448290337.102161-1359648957', 06:53:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:53:43 INFO - '_': '/tools/buildbot/bin/python'} 06:53:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:53:43 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)) 06:53:43 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)) 06:53:43 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)) 06:53:43 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)) 06:53:43 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)) 06:53:43 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)) 06:53:43 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)) 06:53:43 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)) 06:53:43 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)) 06:53:43 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)) 06:53:43 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)) 06:53:43 INFO - Cleaning up... 06:53:43 INFO - Return code: 0 06:53:43 INFO - Running post-action listener: _resource_record_post_action 06:53:43 INFO - Running post-action listener: _start_resource_monitoring 06:53:43 INFO - Starting resource monitoring. 06:53:43 INFO - ##### 06:53:43 INFO - ##### Running install step. 06:53:43 INFO - ##### 06:53:43 INFO - Running pre-action listener: _resource_record_pre_action 06:53:43 INFO - Running main action method: install 06:53:43 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 06:53:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 06:53:43 INFO - Reading from file tmpfile_stdout 06:53:43 INFO - Detecting whether we're running mozinstall >=1.0... 06:53:43 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 06:53:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 06:53:43 INFO - Reading from file tmpfile_stdout 06:53:43 INFO - Output received: 06:53:43 INFO - Usage: mozinstall [options] installer 06:53:43 INFO - Options: 06:53:43 INFO - -h, --help show this help message and exit 06:53:43 INFO - -d DEST, --destination=DEST 06:53:43 INFO - Directory to install application into. [default: 06:53:43 INFO - "/builds/slave/test-pgo"] 06:53:43 INFO - --app=APP Application being installed. [default: firefox] 06:53:43 INFO - mkdir: /builds/slave/test-pgo/build/application 06:53:43 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'] 06:53:43 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 06:53:58 INFO - Reading from file tmpfile_stdout 06:53:58 INFO - Output received: 06:53:58 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 06:53:58 INFO - Running post-action listener: _resource_record_post_action 06:53:58 INFO - ##### 06:53:58 INFO - ##### Running run-tests step. 06:53:58 INFO - ##### 06:53:58 INFO - Running pre-action listener: _resource_record_pre_action 06:53:58 INFO - Running main action method: run_tests 06:53:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 06:53:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 06:53:58 INFO - Python 2.7.3 06:53:58 INFO - Return code: 0 06:53:58 INFO - grabbing minidump binary from tooltool 06:53:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:53:58 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 0x2269a90>, '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 0x22bbf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22bc2e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 06:53:58 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 06:53:58 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 06:53:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:53:58 INFO - Return code: 0 06:53:58 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 06:53:58 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 06:53:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 06:53:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 06:53:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 06:53:58 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/tN1Vpl1qTAWhMzTte2gNJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 06:53:58 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/tN1Vpl1qTAWhMzTte2gNJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-063 --webServer localhost 06:53:58 INFO - Using env: {'DISPLAY': ':0', 06:53:58 INFO - 'HOME': '/home/cltbld', 06:53:58 INFO - 'LANG': 'en_US.UTF-8', 06:53:58 INFO - 'LANGUAGE': 'en_US:en', 06:53:58 INFO - 'LOGNAME': 'cltbld', 06:53:58 INFO - 'MAIL': '/var/mail/cltbld', 06:53:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 06:53:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 06:53:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:53:58 INFO - 'MOZ_NO_REMOTE': '1', 06:53:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 06:53:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:53:58 INFO - 'NO_EM_RESTART': '1', 06:53:58 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:53:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:53:58 INFO - 'PWD': '/builds/slave/test-pgo', 06:53:58 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 06:53:58 INFO - 'SHELL': '/bin/bash', 06:53:58 INFO - 'SHLVL': '1', 06:53:58 INFO - 'TERM': 'linux', 06:53:58 INFO - 'TMOUT': '86400', 06:53:58 INFO - 'USER': 'cltbld', 06:53:58 INFO - 'XDG_SESSION_COOKIE': 'edca6ca23558fe0608d91a4e00000196-1448290337.102161-1359648957', 06:53:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:53:58 INFO - '_': '/tools/buildbot/bin/python'} 06:53:58 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/tN1Vpl1qTAWhMzTte2gNJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--webServer', 'localhost'] with output_timeout 3600 06:53:58 INFO - mozversion INFO | application_buildid: 20151123043002 06:53:58 INFO - mozversion INFO | application_changeset: 8b1fc0961a076e35646d0472a81feefc0074558c 06:53:58 INFO - mozversion INFO | application_display_name: Nightly 06:53:58 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:53:58 INFO - mozversion INFO | application_name: Firefox 06:53:58 INFO - mozversion INFO | application_remotingname: firefox 06:53:58 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 06:53:58 INFO - mozversion INFO | application_vendor: Mozilla 06:53:58 INFO - mozversion INFO | application_version: 45.0a1 06:53:58 INFO - mozversion INFO | platform_buildid: 20151123043002 06:53:58 INFO - mozversion INFO | platform_changeset: 8b1fc0961a076e35646d0472a81feefc0074558c 06:53:58 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 06:53:58 INFO - mozversion INFO | platform_version: 45.0a1 06:53:58 INFO - 2015-11-23 06:53:58,736 DEBUG : using testdate: 1448290438 06:53:58 INFO - 2015-11-23 06:53:58,736 DEBUG : actual date: 1448290438 06:53:58 INFO - 2015-11-23 06:53:58,744 INFO : starting webserver on 'localhost:58993' 06:53:58 INFO - 2015-11-23 06:53:58,746 INFO : Starting test suite talos-linux64-ix-063 06:53:58 INFO - 2015-11-23 06:53:58,746 INFO : Starting test dromaeo_css 06:53:58 INFO - 2015-11-23 06:53:58,746 DEBUG : operating with platform_type : linux_ 06:53:58 INFO - 2015-11-23 06:53:58,746 INFO : Initialising browser for dromaeo_css test... 06:53:58 INFO - 2015-11-23 06:53:58,760 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpz9_f3s/profile http://localhost:58993/getInfo.html 06:54:02 INFO - 2015-11-23 06:54:02,524 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:54:02 INFO - 2015-11-23 06:54:02,525 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:54:02 INFO - 2015-11-23 06:54:02,525 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:54:02 INFO - 2015-11-23 06:54:02,525 DEBUG : BROWSER_OUTPUT: __metrics 06:54:02 INFO - 2015-11-23 06:54:02,633 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:54:03 INFO - 2015-11-23 06:54:03,797 INFO : Browser initialized. 06:54:03 INFO - 2015-11-23 06:54:03,797 INFO : Running cycle 1/1 for dromaeo_css test... 06:54:03 INFO - 2015-11-23 06:54:03,797 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpz9_f3s/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:54:15 INFO - 2015-11-23 06:54:15,558 DEBUG : BROWSER_OUTPUT: RSS: Main: 140685312 06:54:15 INFO - 2015-11-23 06:54:15,558 DEBUG : BROWSER_OUTPUT: 06:55:07 INFO - 2015-11-23 06:55:07,163 DEBUG : BROWSER_OUTPUT: 1448290507159 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] 06:57:15 INFO - 2015-11-23 06:57:15,832 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58993/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58993/tests/dromaeo/cssquery-ext.html) 06:57:17 INFO - 2015-11-23 06:57:17,018 DEBUG : BROWSER_OUTPUT: RSS: Main: 264978432 06:57:17 INFO - 2015-11-23 06:57:17,018 DEBUG : BROWSER_OUTPUT: 07:00:19 INFO - 2015-11-23 07:00:19,423 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58993/tests/dromaeo/cssquery-ext.html (next: http://localhost:58993/tests/dromaeo/cssquery-jquery.html) 07:00:19 INFO - 2015-11-23 07:00:19,996 DEBUG : BROWSER_OUTPUT: RSS: Main: 220782592 07:00:19 INFO - 2015-11-23 07:00:19,996 DEBUG : BROWSER_OUTPUT: 07:03:22 INFO - 2015-11-23 07:03:22,007 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58993/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58993/tests/dromaeo/cssquery-mootools.html) 07:03:22 INFO - 2015-11-23 07:03:22,573 DEBUG : BROWSER_OUTPUT: RSS: Main: 218968064 07:03:22 INFO - 2015-11-23 07:03:22,573 DEBUG : BROWSER_OUTPUT: 07:06:24 INFO - 2015-11-23 07:06:24,474 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58993/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58993/tests/dromaeo/cssquery-prototype.html) 07:06:25 INFO - 2015-11-23 07:06:25,067 DEBUG : BROWSER_OUTPUT: RSS: Main: 200609792 07:06:25 INFO - 2015-11-23 07:06:25,067 DEBUG : BROWSER_OUTPUT: 07:09:27 INFO - 2015-11-23 07:09:27,663 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58993/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58993/tests/dromaeo/cssquery-yui.html) 07:09:28 INFO - 2015-11-23 07:09:28,246 DEBUG : BROWSER_OUTPUT: RSS: Main: 202424320 07:09:28 INFO - 2015-11-23 07:09:28,246 DEBUG : BROWSER_OUTPUT: 07:12:31 INFO - 2015-11-23 07:12:31,055 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58993/tests/dromaeo/cssquery-yui.html (next: http://localhost:58993/tests/dromaeo/cssquery-dojo.html) 07:12:31 INFO - 2015-11-23 07:12:31,305 DEBUG : BROWSER_OUTPUT: RSS: Main: 284913664 07:12:31 INFO - 2015-11-23 07:12:31,305 DEBUG : BROWSER_OUTPUT: 07:12:31 INFO - 2015-11-23 07:12:31,307 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:12:31 INFO - 2015-11-23 07:12:31,307 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:12:31 INFO - 2015-11-23 07:12:31,307 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:12:31 INFO - 2015-11-23 07:12:31,307 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:12:31 INFO - 2015-11-23 07:12:31,309 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3158.8420578971054;3238.060962320927;3277.8361081945895;3288.276579152587;3312.022953228798;5243.86890327742;5296.8146114885985;5373.408925018254;5473.863153421162;5519.11694128939;5317.441668624797;5401.540869026137;5416.485433883775;5422.945770542294;5506.889862202754;4928.38395200599;4978.004399120172;4996.875078123057;5004.099262132815;5016.49835016499;5064.898702025957;5066.645334826564;5112.386513618371;5135.537801597856;5150.021495915783;4830.2030165022725;4874.8537543873745;4959.70241785494;4996.900061998776;5006.4492905780335;4839.153148199051;4882.048000639877;4882.267659851015;4906.852794416173;4931.4821943696115;4650.046740418206;4862.489438608931;4863.951360486385;4885.267209918505;4898.755062246873;5092.28707980883;5092.516210959953;5171.405288391846;5187.584993200535;5198.766055527472;5806.274215723035;5821.359650438449;5826.096954971944;5829.562782791308;5838.2702162229725;5687.886242275132;5802.100674395476;5857.619254748471;5870.530357571384;5872.060470324727;5252.658577192508;5329.546988505943;5333.679979201261;5372.731363431852;5387.892242155174;5893.499052580493;5921.171036054956;5934.317553481319;5979.880402391927;6011.068284415923;5611.8597035073635;5710.685912274782;5811.2445382100905;5813.79651712188;5814.360420353758;5695.886082278331;5776.1624564437925;5852.4147585241135;5853.09277062056;5926.111083337534;5742.16738572913;5747.3103227612955;5756.625819321731;5772.249607551075;5821.505172060422;5736.225609542658;5750.626209296466;5755.136729490526;5757.424257574209;5758.913616295759;4398.538153493901;4424.60178583929;4484.932726009112;4489.169503641837;4493.842715504941;3986.760794352348;4009.7594144351433;4010.578889216649;4012.478377810866;4046.736962097454;5507.614466987353;5511.751971161308;5513.558915286768;5526.47498487643;5552.305961754781;5579.888402231933;5766.682832444256;5770.6249093808765;5781.653100813965;5922.555808314393;5449.918251226235;5465.316835395575;5467.726613669301;5471.863203419946;5474.644148130359;4894.045661096052;4896.290037944478;4896.902061958741;4902.068606964665;4934.851954441372;5817.331006934257;5837.532997360286;5863.824085277363;5917.911231331534;5937.228160339128;5796.797112101056;5818.272715910512;5820.417958204315;5825.446582574648;5829.795957141479;5972.611780234271;5991.64050156992;5992.64044157352;5993.670348130895;5997.520198384032;5635.098384258499;5692.1461780733225;5754.856128596819;5776.480116789509;5886.028805247258;5861.267341582302;5883.823485295448;5922.5261979040715;5942.762289508371;5951.821445356473;5749.712514374348;5780.710964451845;5782.306123265235;5783.132530120515;5792.507636850746;5560.4161563035295;5619.466150715675;5672.829815105389;5675.120356344773;5748.425157484218;5623.240862483676;5625.09998400254;5626.2967129108865;5627.296587926509;5635.915461268002;5722.4277572242445;5729.455701708331;5729.713514324184;5734.5125664319;5744.798932037359;5435.701036442875;5508.779648814003;5523.309586301712;5615.915761263503;5636.943630563642 07:12:31 INFO - 2015-11-23 07:12:31,312 DEBUG : BROWSER_OUTPUT: |1;ext.html;562.8631469082133;576.2048373244921;579.6000759475962;581.4882903045319;599.9310079340875;31288.68711312886;39274.80362598187;39828.20343593133;39834.40248396273;39858;41970.7901460493;42493.57506424935;42495;42505.78747106268;42524;7776.416768742339;7899.526028438312;8837.293016558691;9015.95492022539;10040.598376064949;10292.794144117113;10443.42561159136;10472.2145839062;10479.685609431692;10483.423411712352;10434.843477347846;10457.267991240617;10460.267781255316;10510.894891051106;10548.419836908966;7880.80297992549;8075.394345424117;10464;10630.893691063067;10692.144628429707;10242.7439314017;10393.948030259877;10398;10400.167986561057;10400.323978941344;38673.41989870154;38757.61242387568;38861.80569097165;38939.22121557581;39051.21897562061;3086.8610912508766;3179.5389668497937;3239.87040518379;3805.448210009533;3945.704072194597;29531;30035.249118772204;30054.398912021636;32223;32525.186870328194;3900.278448487039;3970.3845903884944;4010.83956641734;4024.6176613221696;4043.636072753466;254232;255598;256202;257519;257610;54838.177427338625;57894.13158802621;58319.91760576804;58343.70828145832;58369;51089;68659.31340686629;69745.1178417516;69934.3006569938;69946;14154.433822647185;14437.278136093153;14443.78334324986;14540.345684444226;14554.199519026555;10876.61931832398;10971.945140274407;10984.780304393867;10992.450377481095;11000.394978276112;19827.60344793096;20239.065335526266;20269;20295.797042029684;20297.18811247563;7807.882881756778;8084.231997960184;8106.513609183467;8120.228578285053;8195.754127376189;898.725888603969;942.5711301357866;1016.8118898003893;1020.8723909511311;1048.3605000949415;27741;27925;28130;28157.155285341472;28207.71792282092;1052.594751020847;1117.5585643670704;1153.5097583527136;1153.5674122204173;1184.709746112208;14883.553493395215;14904.329305181293;14982.250887455584;15124.092554446768;15131;303312;306226;306782;307211;307572;51005.74497127491;51033.74483127635;51055.48944510507;51168.74415627898;51513.7424312876;1329.7672907241194;1330.2417621955392;1334.7664158772177;1337.6187786481;1341.8456877459023;26615.60076598814;27577;28017.719822802326;28138.71861281361;28177.295567610152;45813;46174.53825461702;46195.30707039464;46263.306050408595;46287;288038;288877.33419994;290529;290969;291497;27336.316592085357;27521.724782751917;31181;31418.528722069645;31766.523502147025;37792.62207377891;38183.809080954416;38559.42160867645;38566;38903.61096389113;32496.83751581227;32526.674733253312;32827.34345313128;32968;40026.79986600048;34417.655823442445;36000.09999750027;36299;39816.60183398129;40472.79763601163;35761.82119089492;35811.462828057076;36204.27591448209;36401;36591;32117.35765284728;32763.508547371333;33659.831700841336;33704.66295337015;37017.44473832948;25504.74495255098;25877;25967.870160649833;26077.478450430506;26157.60763588586 07:12:31 INFO - 2015-11-23 07:12:31,313 DEBUG : BROWSER_OUTPUT: |2;jquery.html;362.1724359837771;365.85914422947167;366.2400518923235;367.602988772126;368.18079772506195;14566.563003109924;14708;16459.83540164598;16779;17338.306467741277;15974.840251597481;16515.917420412912;16819.15904204791;16943.32226710933;17063.488095357126;4912.287718280847;5025.547700706936;5026.623003274751;5028.597712183035;5031.4465408805;3751.531058617673;3829.3107240696804;4992.126377883874;5019.623528235379;5409.134538473845;5500.339959204901;5540.058190107691;5557.166425036236;5557.944420555783;5560.360558535759;5384.865378365553;5520.447955204468;5526.309211348582;5537.778488860441;5543.473370029841;5333.786648534054;5335.546478549328;5337.11937530307;5343.251944727741;5350.839474815762;12449.93775031119;13214.273214973173;13231.338433078308;13249.801252981213;13250.86749132506;1980.7524059492564;1995.2118913029271;1998.8001199879895;2006.6388050151113;2045.836333093349;9493.193078588329;9922.652707155286;10644.520996555173;10986.450677466095;13243.139195952232;1798.8291112344436;1814.528222662104;1825.0509734937891;1836.5041438811445;1857.619188066443;58731.41268587302;59487.70256148691;59554;59862.40137598612;60850.695746520985;9085.36402451822;9195.862062069074;9270.563062725289;9281.628734850665;9306.115918987685;11905;11931.701707457383;11936.164468487295;11943.223690460267;11960.40197990097;6818.045473633695;6894.413974812097;6967.059446974695;7029.789106326818;7092.964535177394;6587.835304117435;6778.932210677929;6858.725650974005;6862.691178896962;6862.862742745217;3955.3275943089743;4189.308764053958;4193.098483825992;4362.934555981663;4388.758618276025;1602.238936505174;1667.2747354900414;1688.560974146706;1739.8956062636282;1785.7232129019762;777.7200207925142;841.4656692999989;842.587132305166;894.0121166111484;921.3872774604947;15069.47256846005;15883.52349429496;16373.263203155886;16665.500034998968;17266.740998885027;854.7948492361788;875.1205038935828;882.9161229683169;940.6331530703031;959.040959040959;9522.428654280766;9562.952185239168;9896.109350158376;10083.949580252052;10147;471720;475486;476114;484688;488050;70217;70987;71678.64160679163;72247.63876180585;73681.26318736852;1146.6273461125168;1148.190525679394;1200.5017917564287;1206.1436380170003;1218.7318789866215;14978;15099.245037747849;15120;15291.158986255863;15320.233988300317;33803.83098084494;33961.320773584885;34037.149071273416;34186.48720269248;34371.14072148217;43694.56305437032;43999.340009899235;44201;44254.55745442504;46757;9229.953850230706;9241.260699144186;9445.433274003582;9813.067758562926;9820.754481138028;11516.596919107791;11554.960053595218;11898.643040708792;16652.333906644082;16707;11565.710857228636;12039.578614748441;13323.733525329246;13704;13951.441942322193;13360.599182024554;13717.108387954751;13814.723705525632;14171.149731016172;14338.641533961734;11162.832557511807;11377.188641805087;11429.59996400122;14065.929670351583;14334.784978225127;9199.632014719336;9208.355415120877;9261.073892610684;9300.302477314364;9384.108509691841;10015.449150296803;10191.94904025475;10879.728006799576;14242.501512447014;14396.496122635657 07:12:31 INFO - 2015-11-23 07:12:31,315 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1346.9393877275522;1691.636298195888;1730.255989924332;1755.4733579926024;1770.6812773700728;6890;7279.526830755997;7371.963140184292;7376.299251571092;7376.668049937753;7553;7658.195889431613;7680.846383072349;7683.270089341504;7688.5771282579435;1957.2562426277993;1989.8905560194185;2200.0759680934048;2260.581792368413;2283.3492454650427;2312.2600767754325;2312.4796920692793;2316.5019520803025;2325.7092863392077;2326.441654003044;2228.7882651148116;2280.1107568048474;2281.349815302639;2282.0643536150183;2284.7486776454575;1978.1296229658976;2019.6869485229813;2163.069879951628;2203.5703037907615;2207.381933058746;2211.6682497625325;2234.4078819112947;2253.4929640830846;2260.4348912771807;2261.9886900565393;7380.963095184544;7428.2571742825285;7428.888566671504;7433.628318584103;7435.776926692208;4663;4769.070031343855;4769.833055843063;4781.091592597395;4782.665213435061;3087.845607719605;3111.4088323218743;3153.2589841387257;3215.5015972524297;3232.305054413289;997.0876647867193;998.6354980432089;1031.6750223679592;1038.5897570459701;1095.5179720922768;10497.265191436603;10534.104601108838;10543.367397956146;10546.419946902917;10555.155587552978;4142.875713728593;4243.151369726067;4277.871663850089;4291.0559676871035;4294.227039132986;9083.591238394289;9086.909130908607;9101.180893719596;9112.453252804853;9120.224780893699;4736.668433209642;4739.099571081483;4771.284307353855;4776.379070720854;4777.092352453023;4272.6154646082;4284.400183974246;4310.137972405531;4316.266234740102;4316.870493885189;3686.299603075407;3724.6834019108137;3725.4411838224482;3746.7751934883995;3776.4335349697217;1194.8745381734793;1194.9163558550817;1196.0252394298618;1198.4786617821276;1199.6880810989205;972.5866506734751;1001.6994901529512;1202.8797120288077;1285.0875878126635;1312.534050412109;6263.123162757218;7296.087989001375;7504.62476876165;7511.248875112555;7516.549007059594;586.8826234753067;586.906095024794;587.3715124816406;596.0046721974313;601.0623427453187;5733.226014488074;5753.1370294456165;5764.596478246566;5821.301443826683;5822.748109156551;9082.727518174466;9237.07629237071;9237.30720195988;9274;9276.72169834906;9195.77010574741;9210.677626283048;9214.769630759285;9215.677451289173;9242.72271831846;6954.365724054843;7153.248908864494;7213.819654508679;7219.74730884427;7222.711091556279;7133.3936615388275;7172.713091476283;7231.891521627285;7239.203687594255;7248.855022899407;8042.557659328793;8182.672693092448;8240.21717936795;8289.005319361715;8298.70954516589;8169.591520424074;8339.416240863082;8469.703560375357;8478.406511544134;8480.74557763268;6569.37590928861;6634.635095069818;6638.502112341497;6641.933580664131;6646.9335306648245;7192.1369435665965;7246.673899674633;7251.492395532473;7260.600666963368;7269.890951635835;6675.866482670416;6797.1843378794865;6857.965710171417;6927.792166235021;6947.478939079489;6391.6804159792755;6448.645324507197;6472.838179045561;6497.805065848032;6632.568883022588;6023.45788879003;6414.775482858077;6720.227173875067;6740.090087838079;6799.2520822708475;6160.9383906160365;6166.290876549254;6200.689965501617;6203.193584834124;6209;6414.390632889868;6440.742370305135;6444.516661250331;6445.065465507381;6455.741770329134 07:12:31 INFO - 2015-11-23 07:12:31,315 DEBUG : BROWSER_OUTPUT: |4;prototype.html;321.20021147343124;324.83920459372615;325.2746375582451;338.7577881814502;343.1027862140502;6032.0951857221435;6077.756889724411;6136.846578835532;6156.6306021638675;6184.165137706408;5883.058710606304;6037.849053773658;6080.635161890279;6090.878182436349;6104.206453161094;4675.812967481296;4676.321933319675;4679.181143299926;4679.204535229019;4690.4371475422995;4466.397036400093;4579.656525760564;4592.425946756655;4682.882927926795;4701.036287561059;4626.907461850761;4632.050429661911;4636.791344389494;4642.628589712832;4653.7440440775745;4625.283081122415;4627;4627.722336659811;4633.4439867215815;4647.581717645395;4063.288924438241;4071.307877660805;4071.470708807866;4084.7549147050977;4094.2220978014084;5694.629849059798;5809.390014048548;5811.738471768781;5817.243758311435;5835;5411.512963833274;5412.269343638598;5415.810446634388;5424.674519528841;5428.891422171574;6181.81454556364;6452.516061295421;6453.774117905851;6457.12828768115;6460.289368169498;4397.406350142754;4447;4534.841280555164;4537.750423726727;4542.091581683677;6641.302663220341;6681.231658359302;6748.865022699617;6756.864862702768;6758.459323254128;4681.157391669532;4685.1332503486965;4686.718796872198;4690.249560070372;4690.695104818176;4668.39310889589;4745.501722319176;4746.454157771831;4748.406449193851;4757.072370887713;5432.837014889559;5440.238366628675;5446.2375267462585;5446.291982042309;5457.2359869618285;6554.4756419487285;6556.950887858015;6559.672016399161;6564.86870262592;6573.769918052845;1652.5455499737668;1686.055808747081;1689.1469807747255;1690.8055573609192;1695.3981336625568;1045.6497073480318;1087.2443651662177;1088.0262165361958;1096.0683419093866;1136.8578927634046;6130.969345153246;6141.232345956755;6143.539234557426;6150.569460137837;6191;6614.107095542136;6664.266930637626;6671.366220209073;6672.866542669217;6676.499262555328;6209.379062093845;6219.471344935731;6262.248530176317;6262.6868656566985;6280.340564240781;3668.706503479769;3699.463577781207;3701.481792549045;3703.851845926187;3711.498947642088;6898.758543450955;7067.858642827115;7072.929270707227;7073.469489788286;7083.6458177090935;6857.348551887562;6971.825704357431;7004.054452648929;7006.159260888726;7007.334303241184;7037.437005039687;7038.753643622551;7044.084269044992;7047.471439641945;7053.188883278489;6518.967405162944;6607.702653380706;6633.2371777246235;6777.525573209828;6780.660966951534;6649.634270114997;6651.933480665131;6651.966740166268;6679.398854103154;6723.630200339028;7026.227115017242;7029.613371264425;7030.367266945999;7035.507514473938;7041.366277035091;4390.626796722315;4493.887652808706;4508.120916421266;4581.175388430114;4628.67599268048;6738.460923126237;6760.425363843931;6763.526553141233;6764.763233286812;6766.2218844831505;6547.148870646785;6556.541042127196;6560.901586476111;6568.638724870178;6584.144061272004;6498.187726534184;6547.181602299713;6549.410553050248;6550.541462097607;6552.934470655233;6422.293547709654;6430.164078669743;6433;6437.130987316839;6444.548881578245;6527.836804079936;6559.376859198369;6564.310747371457;6575.112359831362;6577.276499585138;6310.148130002391;6414.390632889868;6467.967660161669;6477.1579694639395;6492.837679058061 07:12:31 INFO - 2015-11-23 07:12:31,316 DEBUG : BROWSER_OUTPUT: |5;yui.html;787.0681710627915;832.2759199496439;843.8818565400845;846.3694547562067;858.9656413743451;13189.934050329759;13478.46086156555;13494.595162145128;13503.32483375831;13527.932360338185;12383.380830958462;12386.194897331667;12399.56601518947;12400.93799531001;12441.253524788519;665.7703092433103;788.5899332347191;803.441608082383;803.4817542684993;803.6102490292203;669.3473862983576;788.5584072919155;807.8828569857367;808;808.216030450465;836.4019725895984;838.4927119092953;847.3009766942297;847.3475423923575;847.682119205298;668.358375959075;680.9897851532231;835.6657337065192;837.8408102460544;838.5262326785378;581.5812614917253;591.7721677154327;592.0911400999488;592.2744637818638;593.1784478497269;12484.938780203694;12516.123871329011;12547;12577.24536527802;12674.302913339763;11452.828207576893;12258.81611775824;12265.754684906342;12500;12690.936545317214;9849.16282116021;9853.50732463381;9906.455144967023;9932.322658453679;10001;3550.840212190458;3622;3648.1609229877013;3678.2643471305846;3719.3863012602887;44294.77852610716;44437.3334399981;44787.32819007685;44832.55167448316;44854;8864.64541418336;9021.413608115452;9344.177885312434;9374.343795934219;9408.499566348655;17903.820961790476;17992.91003545;17998.280068797103;18073.638527229647;18087;6979.4765392595755;7347.522411043372;7452.956586077953;7453.180150183475;7592.696292148363;4058;4175.15173790816;4180.623743863006;4192.748435093904;4199.097194103282;3068.6010818593886;3118.7349075328398;3382.6279109297957;3443.070370999816;3443.6728510791436;613.6608830778052;620.6493331267819;627.2848952194502;629.9086632438363;632.2697284636253;591.4233622218388;598.8172614289186;614.1862032806549;619.4610688700859;625.6402568523117;8228.136045715113;8523.147685231552;8560.571971401405;8756.343274254456;9242.306826988002;629.5404354821006;634.2579182356653;642.1106767127562;658.3942772649174;668.729164688302;3920.5295364555864;3936.4685767421033;4019.8392064317686;4019.9397009044887;4090.365993271048;52248.738756305975;52507;52559;53133;53903.46096539063;47372;48868.75565622149;49074.263886041736;49305.75347123241;49327;43741.34387984183;44094;44161.558384416385;44270.335944960854;44623;7736.497127686683;7818.218178182136;7944.404169687181;8014.8397032057865;8020.959895200486;33253.33493330168;33586.16034599154;34352.656473434945;34968.10446537538;36486;43778.12443751171;43886.463973760765;44273.77863110664;44329.55670443254;44495;11088.501017454395;11115;11169.888301116885;11246.212765106364;11469.31184128955;12350.197237179555;12692.746145077232;12733.61799146027;13301.268430236043;13306.933465332611;10172.643957461454;10677.51951162184;10690.358578485315;10752.40861752611;11063.778724425305;11238.438078095898;11502.53989840397;11873.643790686294;12064;12212.511499539918;11590.420478976186;11794.351310677652;11927.10546708983;12021.054841563873;12325.075619328407;9388.248940084914;9521.809563808547;9732.75668108303;9834.459104749307;9862.309638325249;9143.0799532099;9147.725568232963;9266.536673166449;10110.898891010997;10133.189344852246 07:12:31 INFO - 2015-11-23 07:12:31,316 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:12:31 INFO - 2015-11-23 07:12:31,316 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:12:31 INFO - 2015-11-23 07:12:31,316 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,977 07:12:31 INFO - 2015-11-23 07:12:31,316 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:12:31 INFO - 2015-11-23 07:12:31,316 DEBUG : BROWSER_OUTPUT: __startTimestamp1448291551306__endTimestamp 07:12:31 INFO - 2015-11-23 07:12:31,317 DEBUG : BROWSER_OUTPUT: 07:12:31 INFO - 2015-11-23 07:12:31,317 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:12:31 INFO - 2015-11-23 07:12:31,317 DEBUG : BROWSER_OUTPUT: Number of tests: 6 07:12:31 INFO - 2015-11-23 07:12:31,317 DEBUG : BROWSER_OUTPUT: 07:12:31 INFO - 2015-11-23 07:12:31,317 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5386.99 Median:5619.47 stddev:598.84 (10.7%) stddev-sans-first:574.61 07:12:31 INFO - 2015-11-23 07:12:31,317 DEBUG : BROWSER_OUTPUT: Values: 3158.8 3238.1 3277.8 3288.3 3312.0 5243.9 5296.8 5373.4 5473.9 5519.1 5317.4 5401.5 5416.5 5422.9 5506.9 4928.4 4978.0 4996.9 5004.1 5016.5 5064.9 5066.6 5112.4 5135.5 5150.0 4830.2 4874.9 4959.7 4996.9 5006.4 4839.2 4882.0 4882.3 4906.9 4931.5 4650.0 4862.5 4864.0 4885.3 4898.8 5092.3 5092.5 5171.4 5187.6 5198.8 5806.3 5821.4 5826.1 5829.6 5838.3 5687.9 5802.1 5857.6 5870.5 5872.1 5252.7 5329.5 5333.7 5372.7 5387.9 5893.5 5921.2 5934.3 5979.9 6011.1 5611.9 5710.7 5811.2 5813.8 5814.4 5695.9 5776.2 5852.4 5853.1 5926.1 5742.2 5747.3 5756.6 5772.2 5821.5 5736.2 5750.6 5755.1 5757.4 5758.9 4398.5 4424.6 4484.9 4489.2 4493.8 3986.8 4009.8 4010.6 4012.5 4046.7 5507.6 5511.8 5513.6 5526.5 5552.3 5579.9 5766.7 5770.6 5781.7 5922.6 5449.9 5465.3 5467.7 5471.9 5474.6 4894.0 4896.3 4896.9 4902.1 4934.9 5817.3 5837.5 5863.8 5917.9 5937.2 5796.8 5818.3 5820.4 5825.4 5829.8 5972.6 5991.6 5992.6 5993.7 5997.5 5635.1 5692.1 5754.9 5776.5 5886.0 5861.3 5883.8 5922.5 5942.8 5951.8 5749.7 5780.7 5782.3 5783.1 5792.5 5560.4 5619.5 5672.8 5675.1 5748.4 5623.2 5625.1 5626.3 5627.3 5635.9 5722.4 5729.5 5729.7 5734.5 5744.8 5435.7 5508.8 5523.3 5615.9 5636.9 07:12:31 INFO - 2015-11-23 07:12:31,317 DEBUG : BROWSER_OUTPUT: 07:12:31 INFO - 2015-11-23 07:12:31,317 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:45679.23 Median:31592.53 stddev:74324.39 (235.3%) stddev-sans-first:74455.69 07:12:31 INFO - 2015-11-23 07:12:31,318 DEBUG : BROWSER_OUTPUT: Values: 562.9 576.2 579.6 581.5 599.9 31288.7 39274.8 39828.2 39834.4 39858.0 41970.8 42493.6 42495.0 42505.8 42524.0 7776.4 7899.5 8837.3 9016.0 10040.6 10292.8 10443.4 10472.2 10479.7 10483.4 10434.8 10457.3 10460.3 10510.9 10548.4 7880.8 8075.4 10464.0 10630.9 10692.1 10242.7 10393.9 10398.0 10400.2 10400.3 38673.4 38757.6 38861.8 38939.2 39051.2 3086.9 3179.5 3239.9 3805.4 3945.7 29531.0 30035.2 30054.4 32223.0 32525.2 3900.3 3970.4 4010.8 4024.6 4043.6 254232.0 255598.0 256202.0 257519.0 257610.0 54838.2 57894.1 58319.9 58343.7 58369.0 51089.0 68659.3 69745.1 69934.3 69946.0 14154.4 14437.3 14443.8 14540.3 14554.2 10876.6 10971.9 10984.8 10992.5 11000.4 19827.6 20239.1 20269.0 20295.8 20297.2 7807.9 8084.2 8106.5 8120.2 8195.8 898.7 942.6 1016.8 1020.9 1048.4 27741.0 27925.0 28130.0 28157.2 28207.7 1052.6 1117.6 1153.5 1153.6 1184.7 14883.6 14904.3 14982.3 15124.1 15131.0 303312.0 306226.0 306782.0 307211.0 307572.0 51005.7 51033.7 51055.5 51168.7 51513.7 1329.8 1330.2 1334.8 1337.6 1341.8 26615.6 27577.0 28017.7 28138.7 28177.3 45813.0 46174.5 46195.3 46263.3 46287.0 288038.0 288877.3 290529.0 290969.0 291497.0 27336.3 27521.7 31181.0 31418.5 31766.5 37792.6 38183.8 38559.4 38566.0 38903.6 32496.8 32526.7 32827.3 32968.0 40026.8 34417.7 36000.1 36299.0 39816.6 40472.8 35761.8 35811.5 36204.3 36401.0 36591.0 32117.4 32763.5 33659.8 33704.7 37017.4 25504.7 25877.0 25967.9 26077.5 26157.6 07:12:31 INFO - 2015-11-23 07:12:31,318 DEBUG : BROWSER_OUTPUT: 07:12:31 INFO - 2015-11-23 07:12:31,318 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26243.73 Median:3790.42 stddev:78336.74 (2066.7%) stddev-sans-first:78532.39 07:12:31 INFO - 2015-11-23 07:12:31,319 DEBUG : BROWSER_OUTPUT: Values: 362.2 365.9 366.2 367.6 368.2 14566.6 14708.0 16459.8 16779.0 17338.3 15974.8 16515.9 16819.2 16943.3 17063.5 4912.3 5025.5 5026.6 5028.6 5031.4 3751.5 3829.3 4992.1 5019.6 5409.1 5500.3 5540.1 5557.2 5557.9 5560.4 5384.9 5520.4 5526.3 5537.8 5543.5 5333.8 5335.5 5337.1 5343.3 5350.8 12449.9 13214.3 13231.3 13249.8 13250.9 1980.8 1995.2 1998.8 2006.6 2045.8 9493.2 9922.7 10644.5 10986.5 13243.1 1798.8 1814.5 1825.1 1836.5 1857.6 58731.4 59487.7 59554.0 59862.4 60850.7 9085.4 9195.9 9270.6 9281.6 9306.1 11905.0 11931.7 11936.2 11943.2 11960.4 6818.0 6894.4 6967.1 7029.8 7093.0 6587.8 6778.9 6858.7 6862.7 6862.9 3955.3 4189.3 4193.1 4362.9 4388.8 1602.2 1667.3 1688.6 1739.9 1785.7 777.7 841.5 842.6 894.0 921.4 15069.5 15883.5 16373.3 16665.5 17266.7 854.8 875.1 882.9 940.6 959.0 9522.4 9563.0 9896.1 10083.9 10147.0 471720.0 475486.0 476114.0 484688.0 488050.0 70217.0 70987.0 71678.6 72247.6 73681.3 1146.6 1148.2 1200.5 1206.1 1218.7 14978.0 15099.2 15120.0 15291.2 15320.2 33803.8 33961.3 34037.1 34186.5 34371.1 43694.6 43999.3 44201.0 44254.6 46757.0 9230.0 9241.3 9445.4 9813.1 9820.8 11516.6 11555.0 11898.6 16652.3 16707.0 11565.7 12039.6 13323.7 13704.0 13951.4 13360.6 13717.1 13814.7 14171.1 14338.6 11162.8 11377.2 11429.6 14065.9 14334.8 9199.6 9208.4 9261.1 9300.3 9384.1 10015.4 10191.9 10879.7 14242.5 14396.5 07:12:31 INFO - 2015-11-23 07:12:31,319 DEBUG : BROWSER_OUTPUT: 07:12:31 INFO - 2015-11-23 07:12:31,319 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5344.59 Median:6201.94 stddev:2765.18 (44.6%) stddev-sans-first:2756.61 07:12:31 INFO - 2015-11-23 07:12:31,320 DEBUG : BROWSER_OUTPUT: Values: 1346.9 1691.6 1730.3 1755.5 1770.7 6890.0 7279.5 7372.0 7376.3 7376.7 7553.0 7658.2 7680.8 7683.3 7688.6 1957.3 1989.9 2200.1 2260.6 2283.3 2312.3 2312.5 2316.5 2325.7 2326.4 2228.8 2280.1 2281.3 2282.1 2284.7 1978.1 2019.7 2163.1 2203.6 2207.4 2211.7 2234.4 2253.5 2260.4 2262.0 7381.0 7428.3 7428.9 7433.6 7435.8 4663.0 4769.1 4769.8 4781.1 4782.7 3087.8 3111.4 3153.3 3215.5 3232.3 997.1 998.6 1031.7 1038.6 1095.5 10497.3 10534.1 10543.4 10546.4 10555.2 4142.9 4243.2 4277.9 4291.1 4294.2 9083.6 9086.9 9101.2 9112.5 9120.2 4736.7 4739.1 4771.3 4776.4 4777.1 4272.6 4284.4 4310.1 4316.3 4316.9 3686.3 3724.7 3725.4 3746.8 3776.4 1194.9 1194.9 1196.0 1198.5 1199.7 972.6 1001.7 1202.9 1285.1 1312.5 6263.1 7296.1 7504.6 7511.2 7516.5 586.9 586.9 587.4 596.0 601.1 5733.2 5753.1 5764.6 5821.3 5822.7 9082.7 9237.1 9237.3 9274.0 9276.7 9195.8 9210.7 9214.8 9215.7 9242.7 6954.4 7153.2 7213.8 7219.7 7222.7 7133.4 7172.7 7231.9 7239.2 7248.9 8042.6 8182.7 8240.2 8289.0 8298.7 8169.6 8339.4 8469.7 8478.4 8480.7 6569.4 6634.6 6638.5 6641.9 6646.9 7192.1 7246.7 7251.5 7260.6 7269.9 6675.9 6797.2 6858.0 6927.8 6947.5 6391.7 6448.6 6472.8 6497.8 6632.6 6023.5 6414.8 6720.2 6740.1 6799.3 6160.9 6166.3 6200.7 6203.2 6209.0 6414.4 6440.7 6444.5 6445.1 6455.7 07:12:31 INFO - 2015-11-23 07:12:31,320 DEBUG : BROWSER_OUTPUT: 07:12:31 INFO - 2015-11-23 07:12:31,320 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5447.97 Median:6147.05 stddev:1649.01 (26.8%) stddev-sans-first:1608.11 07:12:31 INFO - 2015-11-23 07:12:31,320 DEBUG : BROWSER_OUTPUT: Values: 321.2 324.8 325.3 338.8 343.1 6032.1 6077.8 6136.8 6156.6 6184.2 5883.1 6037.8 6080.6 6090.9 6104.2 4675.8 4676.3 4679.2 4679.2 4690.4 4466.4 4579.7 4592.4 4682.9 4701.0 4626.9 4632.1 4636.8 4642.6 4653.7 4625.3 4627.0 4627.7 4633.4 4647.6 4063.3 4071.3 4071.5 4084.8 4094.2 5694.6 5809.4 5811.7 5817.2 5835.0 5411.5 5412.3 5415.8 5424.7 5428.9 6181.8 6452.5 6453.8 6457.1 6460.3 4397.4 4447.0 4534.8 4537.8 4542.1 6641.3 6681.2 6748.9 6756.9 6758.5 4681.2 4685.1 4686.7 4690.2 4690.7 4668.4 4745.5 4746.5 4748.4 4757.1 5432.8 5440.2 5446.2 5446.3 5457.2 6554.5 6557.0 6559.7 6564.9 6573.8 1652.5 1686.1 1689.1 1690.8 1695.4 1045.6 1087.2 1088.0 1096.1 1136.9 6131.0 6141.2 6143.5 6150.6 6191.0 6614.1 6664.3 6671.4 6672.9 6676.5 6209.4 6219.5 6262.2 6262.7 6280.3 3668.7 3699.5 3701.5 3703.9 3711.5 6898.8 7067.9 7072.9 7073.5 7083.6 6857.3 6971.8 7004.1 7006.2 7007.3 7037.4 7038.8 7044.1 7047.5 7053.2 6519.0 6607.7 6633.2 6777.5 6780.7 6649.6 6651.9 6652.0 6679.4 6723.6 7026.2 7029.6 7030.4 7035.5 7041.4 4390.6 4493.9 4508.1 4581.2 4628.7 6738.5 6760.4 6763.5 6764.8 6766.2 6547.1 6556.5 6560.9 6568.6 6584.1 6498.2 6547.2 6549.4 6550.5 6552.9 6422.3 6430.2 6433.0 6437.1 6444.5 6527.8 6559.4 6564.3 6575.1 6577.3 6310.1 6414.4 6468.0 6477.2 6492.8 07:12:31 INFO - 2015-11-23 07:12:31,320 DEBUG : BROWSER_OUTPUT: 07:12:31 INFO - 2015-11-23 07:12:31,321 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13336.67 Median:44809.94 stddev:15075.98 (33.6%) stddev-sans-first:15088.82 07:12:31 INFO - 2015-11-23 07:12:31,322 DEBUG : BROWSER_OUTPUT: Values: 787.1 832.3 843.9 846.4 859.0 13189.9 13478.5 13494.6 13503.3 13527.9 12383.4 12386.2 12399.6 12400.9 12441.3 665.8 788.6 803.4 803.5 803.6 669.3 788.6 807.9 808.0 808.2 836.4 838.5 847.3 847.3 847.7 668.4 681.0 835.7 837.8 838.5 581.6 591.8 592.1 592.3 593.2 12484.9 12516.1 12547.0 12577.2 12674.3 11452.8 12258.8 12265.8 12500.0 12690.9 9849.2 9853.5 9906.5 9932.3 10001.0 3550.8 3622.0 3648.2 3678.3 3719.4 44294.8 44437.3 44787.3 44832.6 44854.0 8864.6 9021.4 9344.2 9374.3 9408.5 17903.8 17992.9 17998.3 18073.6 18087.0 6979.5 7347.5 7453.0 7453.2 7592.7 4058.0 4175.2 4180.6 4192.7 4199.1 3068.6 3118.7 3382.6 3443.1 3443.7 613.7 620.6 627.3 629.9 632.3 591.4 598.8 614.2 619.5 625.6 8228.1 8523.1 8560.6 8756.3 9242.3 629.5 634.3 642.1 658.4 668.7 3920.5 3936.5 4019.8 4019.9 4090.4 52248.7 52507.0 52559.0 53133.0 53903.5 47372.0 48868.8 49074.3 49305.8 49327.0 43741.3 44094.0 44161.6 44270.3 44623.0 7736.5 7818.2 7944.4 8014.8 8021.0 33253.3 33586.2 34352.7 34968.1 36486.0 43778.1 43886.5 44273.8 44329.6 44495.0 11088.5 11115.0 11169.9 11246.2 11469.3 12350.2 12692.7 12733.6 13301.3 13306.9 10172.6 10677.5 10690.4 10752.4 11063.8 11238.4 11502.5 11873.6 12064.0 12212.5 11590.4 11794.4 11927.1 12021.1 12325.1 9388.2 9521.8 9732.8 9834.5 9862.3 9143.1 9147.7 9266.5 10110.9 10133.2 07:12:31 INFO - 2015-11-23 07:12:31,322 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:12:31 INFO - 2015-11-23 07:12:31,322 DEBUG : BROWSER_OUTPUT: 07:12:31 INFO - 2015-11-23 07:12:31,990 INFO : Browser exited with error code: 0 07:12:32 INFO - 2015-11-23 07:12:32,008 INFO : Completed test dromaeo_css (00:18:33) 07:12:32 INFO - 2015-11-23 07:12:32,009 INFO : Starting test kraken 07:12:32 INFO - 2015-11-23 07:12:32,009 DEBUG : operating with platform_type : linux_ 07:12:32 INFO - 2015-11-23 07:12:32,009 INFO : Initialising browser for kraken test... 07:12:32 INFO - 2015-11-23 07:12:32,015 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpLXyLTA/profile http://localhost:58993/getInfo.html 07:12:35 INFO - 2015-11-23 07:12:35,613 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:12:35 INFO - 2015-11-23 07:12:35,613 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:12:35 INFO - 2015-11-23 07:12:35,613 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:12:35 INFO - 2015-11-23 07:12:35,613 DEBUG : BROWSER_OUTPUT: __metrics 07:12:35 INFO - 2015-11-23 07:12:35,694 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:12:36 INFO - 2015-11-23 07:12:36,885 INFO : Browser initialized. 07:12:36 INFO - 2015-11-23 07:12:36,886 INFO : Running cycle 1/1 for kraken test... 07:12:36 INFO - 2015-11-23 07:12:36,886 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpLXyLTA/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:12:48 INFO - 2015-11-23 07:12:48,694 DEBUG : BROWSER_OUTPUT: RSS: Main: 139730944 07:12:48 INFO - 2015-11-23 07:12:48,695 DEBUG : BROWSER_OUTPUT: 07:12:51 INFO - 2015-11-23 07:12:51,182 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58993/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58993/tests/kraken/driver.html?testName=audio-beat-detection) 07:12:51 INFO - 2015-11-23 07:12:51,763 DEBUG : BROWSER_OUTPUT: RSS: Main: 178089984 07:12:51 INFO - 2015-11-23 07:12:51,763 DEBUG : BROWSER_OUTPUT: 07:12:54 INFO - 2015-11-23 07:12:54,373 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58993/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58993/tests/kraken/driver.html?testName=audio-dft) 07:12:54 INFO - 2015-11-23 07:12:54,940 DEBUG : BROWSER_OUTPUT: RSS: Main: 167800832 07:12:54 INFO - 2015-11-23 07:12:54,940 DEBUG : BROWSER_OUTPUT: 07:12:57 INFO - 2015-11-23 07:12:57,839 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58993/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58993/tests/kraken/driver.html?testName=audio-fft) 07:12:58 INFO - 2015-11-23 07:12:58,400 DEBUG : BROWSER_OUTPUT: RSS: Main: 150335488 07:12:58 INFO - 2015-11-23 07:12:58,400 DEBUG : BROWSER_OUTPUT: 07:13:00 INFO - 2015-11-23 07:13:00,413 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58993/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58993/tests/kraken/driver.html?testName=audio-oscillator) 07:13:00 INFO - 2015-11-23 07:13:00,979 DEBUG : BROWSER_OUTPUT: RSS: Main: 154013696 07:13:00 INFO - 2015-11-23 07:13:00,979 DEBUG : BROWSER_OUTPUT: 07:13:03 INFO - 2015-11-23 07:13:03,157 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58993/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58993/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:13:03 INFO - 2015-11-23 07:13:03,718 DEBUG : BROWSER_OUTPUT: RSS: Main: 155643904 07:13:03 INFO - 2015-11-23 07:13:03,718 DEBUG : BROWSER_OUTPUT: 07:13:06 INFO - 2015-11-23 07:13:06,667 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58993/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58993/tests/kraken/driver.html?testName=imaging-darkroom) 07:13:07 INFO - 2015-11-23 07:13:07,248 DEBUG : BROWSER_OUTPUT: RSS: Main: 156045312 07:13:07 INFO - 2015-11-23 07:13:07,248 DEBUG : BROWSER_OUTPUT: 07:13:10 INFO - 2015-11-23 07:13:10,638 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58993/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58993/tests/kraken/driver.html?testName=imaging-desaturate) 07:13:11 INFO - 2015-11-23 07:13:11,219 DEBUG : BROWSER_OUTPUT: RSS: Main: 156450816 07:13:11 INFO - 2015-11-23 07:13:11,219 DEBUG : BROWSER_OUTPUT: 07:13:13 INFO - 2015-11-23 07:13:13,968 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58993/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58993/tests/kraken/driver.html?testName=json-parse-financial) 07:13:14 INFO - 2015-11-23 07:13:14,537 DEBUG : BROWSER_OUTPUT: RSS: Main: 156545024 07:13:14 INFO - 2015-11-23 07:13:14,537 DEBUG : BROWSER_OUTPUT: 07:13:16 INFO - 2015-11-23 07:13:16,077 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58993/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58993/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:13:16 INFO - 2015-11-23 07:13:16,638 DEBUG : BROWSER_OUTPUT: RSS: Main: 165937152 07:13:16 INFO - 2015-11-23 07:13:16,638 DEBUG : BROWSER_OUTPUT: 07:13:18 INFO - 2015-11-23 07:13:18,454 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58993/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58993/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:13:19 INFO - 2015-11-23 07:13:19,060 DEBUG : BROWSER_OUTPUT: RSS: Main: 165670912 07:13:19 INFO - 2015-11-23 07:13:19,060 DEBUG : BROWSER_OUTPUT: 07:13:21 INFO - 2015-11-23 07:13:21,158 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58993/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58993/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:13:21 INFO - 2015-11-23 07:13:21,727 DEBUG : BROWSER_OUTPUT: RSS: Main: 174399488 07:13:21 INFO - 2015-11-23 07:13:21,727 DEBUG : BROWSER_OUTPUT: 07:13:24 INFO - 2015-11-23 07:13:24,194 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58993/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58993/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:13:24 INFO - 2015-11-23 07:13:24,775 DEBUG : BROWSER_OUTPUT: RSS: Main: 181403648 07:13:24 INFO - 2015-11-23 07:13:24,776 DEBUG : BROWSER_OUTPUT: 07:13:27 INFO - 2015-11-23 07:13:27,331 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58993/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58993/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:13:27 INFO - 2015-11-23 07:13:27,905 DEBUG : BROWSER_OUTPUT: RSS: Main: 178913280 07:13:27 INFO - 2015-11-23 07:13:27,905 DEBUG : BROWSER_OUTPUT: 07:13:29 INFO - 2015-11-23 07:13:29,575 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58993/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58993/tests/kraken/driver.html?testName=ai-astar) 07:13:29 INFO - 2015-11-23 07:13:29,824 DEBUG : BROWSER_OUTPUT: RSS: Main: 237850624 07:13:29 INFO - 2015-11-23 07:13:29,825 DEBUG : BROWSER_OUTPUT: 07:13:29 INFO - 2015-11-23 07:13:29,826 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:13:29 INFO - 2015-11-23 07:13:29,826 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:13:29 INFO - 2015-11-23 07:13:29,826 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:13:29 INFO - 2015-11-23 07:13:29,826 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:13:29 INFO - 2015-11-23 07:13:29,827 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;112;105;111;111;111;102;112;114;110 07:13:29 INFO - 2015-11-23 07:13:29,827 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;154;124;151;167;125;146;149;125;169;154 07:13:29 INFO - 2015-11-23 07:13:29,827 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;162;161;160;161;161;159;163;162;161 07:13:29 INFO - 2015-11-23 07:13:29,827 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;72;87;93;73;71;71;134;92;71 07:13:29 INFO - 2015-11-23 07:13:29,828 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;90;91;137;91;91;91;143;91;92;140 07:13:29 INFO - 2015-11-23 07:13:29,828 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;111;111;110;109;110;109;109;109;109;109 07:13:29 INFO - 2015-11-23 07:13:29,828 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;146;145;146;147;146;145;145;145;145 07:13:29 INFO - 2015-11-23 07:13:29,828 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;95;95;96;98;96;96;95;95 07:13:29 INFO - 2015-11-23 07:13:29,828 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;59;58;57;58;59;59;57;65;55;55 07:13:29 INFO - 2015-11-23 07:13:29,828 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;68;69;68;69;69;70;69;69;69 07:13:29 INFO - 2015-11-23 07:13:29,828 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;85;84;85;93;84;85;84;86;85 07:13:29 INFO - 2015-11-23 07:13:29,828 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;128;140;115;128;129;117;123;125;126;120 07:13:29 INFO - 2015-11-23 07:13:29,829 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;140;152;154;154;154;145;157;149;146;147 07:13:29 INFO - 2015-11-23 07:13:29,829 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;67;67;68;67;70;69;65;65;67 07:13:29 INFO - 2015-11-23 07:13:29,829 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:13:29 INFO - 2015-11-23 07:13:29,829 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:13:29 INFO - 2015-11-23 07:13:29,829 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,913 07:13:29 INFO - 2015-11-23 07:13:29,829 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:13:29 INFO - 2015-11-23 07:13:29,829 DEBUG : BROWSER_OUTPUT: __startTimestamp1448291609825__endTimestamp 07:13:29 INFO - 2015-11-23 07:13:29,830 DEBUG : BROWSER_OUTPUT: 07:13:29 INFO - 2015-11-23 07:13:29,833 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:13:29 INFO - 2015-11-23 07:13:29,833 DEBUG : BROWSER_OUTPUT: Number of tests: 14 07:13:29 INFO - 2015-11-23 07:13:29,833 DEBUG : BROWSER_OUTPUT: 07:13:29 INFO - 2015-11-23 07:13:29,834 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.00 Median:111.50 stddev:3.65 (3.3%) stddev-sans-first:3.80 07:13:29 INFO - 2015-11-23 07:13:29,834 DEBUG : BROWSER_OUTPUT: Values: 112.0 112.0 105.0 111.0 111.0 111.0 102.0 112.0 114.0 110.0 07:13:29 INFO - 2015-11-23 07:13:29,834 DEBUG : BROWSER_OUTPUT: 07:13:29 INFO - 2015-11-23 07:13:29,834 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:146.40 Median:152.50 stddev:16.65 (10.9%) stddev-sans-first:17.44 07:13:29 INFO - 2015-11-23 07:13:29,834 DEBUG : BROWSER_OUTPUT: Values: 154.0 124.0 151.0 167.0 125.0 146.0 149.0 125.0 169.0 154.0 07:13:29 INFO - 2015-11-23 07:13:29,834 DEBUG : BROWSER_OUTPUT: 07:13:29 INFO - 2015-11-23 07:13:29,835 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.20 Median:161.50 stddev:1.14 (0.7%) stddev-sans-first:1.17 07:13:29 INFO - 2015-11-23 07:13:29,835 DEBUG : BROWSER_OUTPUT: Values: 162.0 162.0 161.0 160.0 161.0 161.0 159.0 163.0 162.0 161.0 07:13:29 INFO - 2015-11-23 07:13:29,835 DEBUG : BROWSER_OUTPUT: 07:13:29 INFO - 2015-11-23 07:13:29,835 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:83.70 Median:73.00 stddev:19.85 (27.2%) stddev-sans-first:20.67 07:13:29 INFO - 2015-11-23 07:13:29,835 DEBUG : BROWSER_OUTPUT: Values: 73.0 72.0 87.0 93.0 73.0 71.0 71.0 134.0 92.0 71.0 07:13:29 INFO - 2015-11-23 07:13:29,835 DEBUG : BROWSER_OUTPUT: 07:13:29 INFO - 2015-11-23 07:13:29,836 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.70 Median:91.00 stddev:23.72 (26.1%) stddev-sans-first:24.46 07:13:29 INFO - 2015-11-23 07:13:29,836 DEBUG : BROWSER_OUTPUT: Values: 90.0 91.0 137.0 91.0 91.0 91.0 143.0 91.0 92.0 140.0 07:13:29 INFO - 2015-11-23 07:13:29,836 DEBUG : BROWSER_OUTPUT: 07:13:29 INFO - 2015-11-23 07:13:29,836 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:109.50 stddev:0.84 (0.8%) stddev-sans-first:0.73 07:13:29 INFO - 2015-11-23 07:13:29,836 DEBUG : BROWSER_OUTPUT: Values: 111.0 111.0 110.0 109.0 110.0 109.0 109.0 109.0 109.0 109.0 07:13:29 INFO - 2015-11-23 07:13:29,836 DEBUG : BROWSER_OUTPUT: 07:13:29 INFO - 2015-11-23 07:13:29,837 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.50 Median:145.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 07:13:29 INFO - 2015-11-23 07:13:29,837 DEBUG : BROWSER_OUTPUT: Values: 145.0 146.0 145.0 146.0 147.0 146.0 145.0 145.0 145.0 145.0 07:13:29 INFO - 2015-11-23 07:13:29,837 DEBUG : BROWSER_OUTPUT: 07:13:29 INFO - 2015-11-23 07:13:29,837 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.95 (1.0%) stddev-sans-first:0.97 07:13:29 INFO - 2015-11-23 07:13:29,837 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 95.0 95.0 96.0 98.0 96.0 96.0 95.0 95.0 07:13:29 INFO - 2015-11-23 07:13:29,837 DEBUG : BROWSER_OUTPUT: 07:13:29 INFO - 2015-11-23 07:13:29,838 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:58.20 Median:58.50 stddev:2.82 (4.8%) stddev-sans-first:2.98 07:13:29 INFO - 2015-11-23 07:13:29,838 DEBUG : BROWSER_OUTPUT: Values: 59.0 58.0 57.0 58.0 59.0 59.0 57.0 65.0 55.0 55.0 07:13:29 INFO - 2015-11-23 07:13:29,838 DEBUG : BROWSER_OUTPUT: 07:13:29 INFO - 2015-11-23 07:13:29,838 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.80 Median:69.00 stddev:0.63 (0.9%) stddev-sans-first:0.60 07:13:29 INFO - 2015-11-23 07:13:29,838 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 69.0 68.0 69.0 69.0 70.0 69.0 69.0 69.0 07:13:29 INFO - 2015-11-23 07:13:29,838 DEBUG : BROWSER_OUTPUT: 07:13:29 INFO - 2015-11-23 07:13:29,838 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.50 Median:85.00 stddev:2.72 (3.2%) stddev-sans-first:2.83 07:13:29 INFO - 2015-11-23 07:13:29,838 DEBUG : BROWSER_OUTPUT: Values: 84.0 85.0 84.0 85.0 93.0 84.0 85.0 84.0 86.0 85.0 07:13:29 INFO - 2015-11-23 07:13:29,838 DEBUG : BROWSER_OUTPUT: 07:13:29 INFO - 2015-11-23 07:13:29,838 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:125.10 Median:127.00 stddev:7.09 (5.6%) stddev-sans-first:7.45 07:13:29 INFO - 2015-11-23 07:13:29,838 DEBUG : BROWSER_OUTPUT: Values: 128.0 140.0 115.0 128.0 129.0 117.0 123.0 125.0 126.0 120.0 07:13:29 INFO - 2015-11-23 07:13:29,838 DEBUG : BROWSER_OUTPUT: 07:13:29 INFO - 2015-11-23 07:13:29,839 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.80 Median:153.00 stddev:5.29 (3.5%) stddev-sans-first:4.26 07:13:29 INFO - 2015-11-23 07:13:29,839 DEBUG : BROWSER_OUTPUT: Values: 140.0 152.0 154.0 154.0 154.0 145.0 157.0 149.0 146.0 147.0 07:13:29 INFO - 2015-11-23 07:13:29,839 DEBUG : BROWSER_OUTPUT: 07:13:29 INFO - 2015-11-23 07:13:29,839 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.50 stddev:1.57 (2.3%) stddev-sans-first:1.64 07:13:29 INFO - 2015-11-23 07:13:29,839 DEBUG : BROWSER_OUTPUT: Values: 68.0 67.0 67.0 68.0 67.0 70.0 69.0 65.0 65.0 67.0 07:13:29 INFO - 2015-11-23 07:13:29,839 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:13:29 INFO - 2015-11-23 07:13:29,839 DEBUG : BROWSER_OUTPUT: 07:13:30 INFO - 2015-11-23 07:13:30,638 INFO : Browser exited with error code: 0 07:13:30 INFO - 2015-11-23 07:13:30,692 INFO : Completed test kraken (00:00:58) 07:13:30 INFO - 2015-11-23 07:13:30,692 INFO : Starting test v8_7 07:13:30 INFO - 2015-11-23 07:13:30,692 DEBUG : operating with platform_type : linux_ 07:13:30 INFO - 2015-11-23 07:13:30,692 INFO : Initialising browser for v8_7 test... 07:13:30 INFO - 2015-11-23 07:13:30,698 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp32QrIl/profile http://localhost:58993/getInfo.html 07:13:34 INFO - 2015-11-23 07:13:34,336 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:13:34 INFO - 2015-11-23 07:13:34,336 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:13:34 INFO - 2015-11-23 07:13:34,336 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:13:34 INFO - 2015-11-23 07:13:34,336 DEBUG : BROWSER_OUTPUT: __metrics 07:13:34 INFO - 2015-11-23 07:13:34,397 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:13:35 INFO - 2015-11-23 07:13:35,569 INFO : Browser initialized. 07:13:35 INFO - 2015-11-23 07:13:35,569 INFO : Running cycle 1/1 for v8_7 test... 07:13:35 INFO - 2015-11-23 07:13:35,570 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp32QrIl/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:13:47 INFO - 2015-11-23 07:13:47,355 DEBUG : BROWSER_OUTPUT: RSS: Main: 139747328 07:13:47 INFO - 2015-11-23 07:13:47,355 DEBUG : BROWSER_OUTPUT: 07:14:08 INFO - 2015-11-23 07:14:08,736 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58993/tests/v8_7/run.html (next: http://localhost:58993/tests/v8_7/run.html) 07:14:08 INFO - 2015-11-23 07:14:08,986 DEBUG : BROWSER_OUTPUT: RSS: Main: 577449984 07:14:08 INFO - 2015-11-23 07:14:08,986 DEBUG : BROWSER_OUTPUT: 07:14:08 INFO - 2015-11-23 07:14:08,986 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:14:08 INFO - 2015-11-23 07:14:08,986 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:14:08 INFO - 2015-11-23 07:14:08,987 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:14:08 INFO - 2015-11-23 07:14:08,987 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:14:08 INFO - 2015-11-23 07:14:08,987 DEBUG : BROWSER_OUTPUT: |0;Richards;163.47882949158085 07:14:08 INFO - 2015-11-23 07:14:08,987 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;194.47685725398676 07:14:08 INFO - 2015-11-23 07:14:08,987 DEBUG : BROWSER_OUTPUT: |2;Encrypt;285.143997718848 07:14:08 INFO - 2015-11-23 07:14:08,987 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5040.201005025126 07:14:08 INFO - 2015-11-23 07:14:08,988 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1108.6474501108648 07:14:08 INFO - 2015-11-23 07:14:08,988 DEBUG : BROWSER_OUTPUT: |5;Earley;777.6049766718507 07:14:08 INFO - 2015-11-23 07:14:08,988 DEBUG : BROWSER_OUTPUT: |6;Boyer;12144.578313253012 07:14:08 INFO - 2015-11-23 07:14:08,988 DEBUG : BROWSER_OUTPUT: |7;RegExp;25897.4358974359 07:14:08 INFO - 2015-11-23 07:14:08,988 DEBUG : BROWSER_OUTPUT: |8;Splay;660.1178781925344 07:14:08 INFO - 2015-11-23 07:14:08,989 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4854.368932038835 07:14:08 INFO - 2015-11-23 07:14:08,989 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:14:08 INFO - 2015-11-23 07:14:08,989 DEBUG : BROWSER_OUTPUT: __startTimestamp1448291648984__endTimestamp 07:14:08 INFO - 2015-11-23 07:14:08,989 DEBUG : BROWSER_OUTPUT: 07:14:08 INFO - 2015-11-23 07:14:08,989 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:14:08 INFO - 2015-11-23 07:14:08,989 DEBUG : BROWSER_OUTPUT: Number of tests: 10 07:14:08 INFO - 2015-11-23 07:14:08,990 DEBUG : BROWSER_OUTPUT: 07:14:08 INFO - 2015-11-23 07:14:08,990 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:163.48 Median:163.48 stddev:0.00 (0.0%) 07:14:08 INFO - 2015-11-23 07:14:08,990 DEBUG : BROWSER_OUTPUT: Values: 163.5 07:14:08 INFO - 2015-11-23 07:14:08,990 DEBUG : BROWSER_OUTPUT: 07:14:08 INFO - 2015-11-23 07:14:08,990 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:194.48 Median:194.48 stddev:0.00 (0.0%) 07:14:08 INFO - 2015-11-23 07:14:08,990 DEBUG : BROWSER_OUTPUT: Values: 194.5 07:14:08 INFO - 2015-11-23 07:14:08,990 DEBUG : BROWSER_OUTPUT: 07:14:08 INFO - 2015-11-23 07:14:08,991 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:285.14 Median:285.14 stddev:0.00 (0.0%) 07:14:08 INFO - 2015-11-23 07:14:08,991 DEBUG : BROWSER_OUTPUT: Values: 285.1 07:14:08 INFO - 2015-11-23 07:14:08,992 DEBUG : BROWSER_OUTPUT: 07:14:08 INFO - 2015-11-23 07:14:08,992 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5040.20 Median:5040.20 stddev:0.00 (0.0%) 07:14:08 INFO - 2015-11-23 07:14:08,992 DEBUG : BROWSER_OUTPUT: Values: 5040.2 07:14:08 INFO - 2015-11-23 07:14:08,993 DEBUG : BROWSER_OUTPUT: 07:14:09 INFO - 2015-11-23 07:14:08,993 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1108.65 Median:1108.65 stddev:0.00 (0.0%) 07:14:09 INFO - 2015-11-23 07:14:08,993 DEBUG : BROWSER_OUTPUT: Values: 1108.6 07:14:09 INFO - 2015-11-23 07:14:08,993 DEBUG : BROWSER_OUTPUT: 07:14:09 INFO - 2015-11-23 07:14:08,993 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:777.60 Median:777.60 stddev:0.00 (0.0%) 07:14:09 INFO - 2015-11-23 07:14:08,993 DEBUG : BROWSER_OUTPUT: Values: 777.6 07:14:09 INFO - 2015-11-23 07:14:08,993 DEBUG : BROWSER_OUTPUT: 07:14:09 INFO - 2015-11-23 07:14:08,993 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12144.58 Median:12144.58 stddev:0.00 (0.0%) 07:14:09 INFO - 2015-11-23 07:14:08,994 DEBUG : BROWSER_OUTPUT: Values: 12144.6 07:14:09 INFO - 2015-11-23 07:14:08,994 DEBUG : BROWSER_OUTPUT: 07:14:09 INFO - 2015-11-23 07:14:08,994 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25897.44 Median:25897.44 stddev:0.00 (0.0%) 07:14:09 INFO - 2015-11-23 07:14:08,994 DEBUG : BROWSER_OUTPUT: Values: 25897.4 07:14:09 INFO - 2015-11-23 07:14:08,994 DEBUG : BROWSER_OUTPUT: 07:14:09 INFO - 2015-11-23 07:14:08,994 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:660.12 Median:660.12 stddev:0.00 (0.0%) 07:14:09 INFO - 2015-11-23 07:14:08,994 DEBUG : BROWSER_OUTPUT: Values: 660.1 07:14:09 INFO - 2015-11-23 07:14:08,995 DEBUG : BROWSER_OUTPUT: 07:14:09 INFO - 2015-11-23 07:14:08,995 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4854.37 Median:4854.37 stddev:0.00 (0.0%) 07:14:09 INFO - 2015-11-23 07:14:08,995 DEBUG : BROWSER_OUTPUT: Values: 4854.4 07:14:09 INFO - 2015-11-23 07:14:08,995 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:14:09 INFO - 2015-11-23 07:14:08,995 DEBUG : BROWSER_OUTPUT: 07:14:09 INFO - 2015-11-23 07:14:09,782 INFO : Browser exited with error code: 0 07:14:09 INFO - 2015-11-23 07:14:09,799 INFO : Completed test v8_7 (00:00:39) 07:14:10 INFO - 2015-11-23 07:14:10,008 INFO : Completed test suite (00:20:11) 07:14:10 INFO - 2015-11-23 07:14:10,009 DEBUG : Working with test: dromaeo_css 07:14:10 INFO - 2015-11-23 07:14:10,009 DEBUG : Generating results file: dromaeo_css 07:14:10 INFO - 2015-11-23 07:14:10,010 DEBUG : Working with test: kraken 07:14:10 INFO - 2015-11-23 07:14:10,010 DEBUG : Generating results file: kraken 07:14:10 INFO - 2015-11-23 07:14:10,010 INFO : javascript benchmark 07:14:10 INFO - 2015-11-23 07:14:10,010 DEBUG : Working with test: v8_7 07:14:10 INFO - 2015-11-23 07:14:10,011 DEBUG : Generating results file: v8_7 07:14:10 INFO - 2015-11-23 07:14:10,011 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:14:10 INFO - 2015-11-23 07:14:10,072 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 07:14:10 INFO - 2015-11-23 07:14:10,072 DEBUG : process_Request line: dromaeo_css 6928.77 graph.html#tests=[[72,1,35]] 07:14:10 INFO - 2015-11-23 07:14:10,072 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:14:10 INFO - 2015-11-23 07:14:10,104 DEBUG : process_Request line: kraken 1512.50 graph.html#tests=[[232,1,35]] 07:14:10 INFO - 2015-11-23 07:14:10,104 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:14:10 INFO - 2015-11-23 07:14:10,134 DEBUG : process_Request line: v8_7 20872.52 graph.html#tests=[[230,1,35]] 07:14:10 INFO - 2015-11-23 07:14:10,135 INFO : javascript benchmark 07:14:10 INFO - 2015-11-23 07:14:10,139 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3158.8420578971054, 3238.060962320927, 3277.8361081945895, 3288.276579152587, 3312.022953228798, 5243.86890327742, 5296.8146114885985, 5373.408925018254, 5473.863153421162, 5519.11694128939, 5317.441668624797, 5401.540869026137, 5416.485433883775, 5422.945770542294, 5506.889862202754, 4928.38395200599, 4978.004399120172, 4996.875078123057, 5004.099262132815, 5016.49835016499, 5064.898702025957, 5066.645334826564, 5112.386513618371, 5135.537801597856, 5150.021495915783, 4830.2030165022725, 4874.8537543873745, 4959.70241785494, 4996.900061998776, 5006.4492905780335, 4839.153148199051, 4882.048000639877, 4882.267659851015, 4906.852794416173, 4931.4821943696115, 4650.046740418206, 4862.489438608931, 4863.951360486385, 4885.267209918505, 4898.755062246873, 5092.28707980883, 5092.516210959953, 5171.405288391846, 5187.584993200535, 5198.766055527472, 5806.274215723035, 5821.359650438449, 5826.096954971944, 5829.562782791308, 5838.2702162229725, 5687.886242275132, 5802.100674395476, 5857.619254748471, 5870.530357571384, 5872.060470324727, 5252.658577192508, 5329.546988505943, 5333.679979201261, 5372.731363431852, 5387.892242155174, 5893.499052580493, 5921.171036054956, 5934.317553481319, 5979.880402391927, 6011.068284415923, 5611.8597035073635, 5710.685912274782, 5811.2445382100905, 5813.79651712188, 5814.360420353758, 5695.886082278331, 5776.1624564437925, 5852.4147585241135, 5853.09277062056, 5926.111083337534, 5742.16738572913, 5747.3103227612955, 5756.625819321731, 5772.249607551075, 5821.505172060422, 5736.225609542658, 5750.626209296466, 5755.136729490526, 5757.424257574209, 5758.913616295759, 4398.538153493901, 4424.60178583929, 4484.932726009112, 4489.169503641837, 4493.842715504941, 3986.760794352348, 4009.7594144351433, 4010.578889216649, 4012.478377810866, 4046.736962097454, 5507.614466987353, 5511.751971161308, 5513.558915286768, 5526.47498487643, 5552.305961754781, 5579.888402231933, 5766.682832444256, 5770.6249093808765, 5781.653100813965, 5922.555808314393, 5449.918251226235, 5465.316835395575, 5467.726613669301, 5471.863203419946, 5474.644148130359, 4894.045661096052, 4896.290037944478, 4896.902061958741, 4902.068606964665, 4934.851954441372, 5817.331006934257, 5837.532997360286, 5863.824085277363, 5917.911231331534, 5937.228160339128, 5796.797112101056, 5818.272715910512, 5820.417958204315, 5825.446582574648, 5829.795957141479, 5972.611780234271, 5991.64050156992, 5992.64044157352, 5993.670348130895, 5997.520198384032, 5635.098384258499, 5692.1461780733225, 5754.856128596819, 5776.480116789509, 5886.028805247258, 5861.267341582302, 5883.823485295448, 5922.5261979040715, 5942.762289508371, 5951.821445356473, 5749.712514374348, 5780.710964451845, 5782.306123265235, 5783.132530120515, 5792.507636850746, 5560.4161563035295, 5619.466150715675, 5672.829815105389, 5675.120356344773, 5748.425157484218, 5623.240862483676, 5625.09998400254, 5626.2967129108865, 5627.296587926509, 5635.915461268002, 5722.4277572242445, 5729.455701708331, 5729.713514324184, 5734.5125664319, 5744.798932037359, 5435.701036442875, 5508.779648814003, 5523.309586301712, 5615.915761263503, 5636.943630563642], "unit": "ms", "name": "dojo.html", "value": 5348.251922340352}, {"lowerIsBetter": false, "replicates": [562.8631469082133, 576.2048373244921, 579.6000759475962, 581.4882903045319, 599.9310079340875, 31288.68711312886, 39274.80362598187, 39828.20343593133, 39834.40248396273, 39858.0, 41970.7901460493, 42493.57506424935, 42495.0, 42505.78747106268, 42524.0, 7776.416768742339, 7899.526028438312, 8837.293016558691, 9015.95492022539, 10040.598376064949, 10292.794144117113, 10443.42561159136, 10472.2145839062, 10479.685609431692, 10483.423411712352, 10434.843477347846, 10457.267991240617, 10460.267781255316, 10510.894891051106, 10548.419836908966, 7880.80297992549, 8075.394345424117, 10464.0, 10630.893691063067, 10692.144628429707, 10242.7439314017, 10393.948030259877, 10398.0, 10400.167986561057, 10400.323978941344, 38673.41989870154, 38757.61242387568, 38861.80569097165, 38939.22121557581, 39051.21897562061, 3086.8610912508766, 3179.5389668497937, 3239.87040518379, 3805.448210009533, 3945.704072194597, 29531.0, 30035.249118772204, 30054.398912021636, 32223.0, 32525.186870328194, 3900.278448487039, 3970.3845903884944, 4010.83956641734, 4024.6176613221696, 4043.636072753466, 254232.0, 255598.0, 256202.0, 257519.0, 257610.0, 54838.177427338625, 57894.13158802621, 58319.91760576804, 58343.70828145832, 58369.0, 51089.0, 68659.31340686629, 69745.1178417516, 69934.3006569938, 69946.0, 14154.433822647185, 14437.278136093153, 14443.78334324986, 14540.345684444226, 14554.199519026555, 10876.61931832398, 10971.945140274407, 10984.780304393867, 10992.450377481095, 11000.394978276112, 19827.60344793096, 20239.065335526266, 20269.0, 20295.797042029684, 20297.18811247563, 7807.882881756778, 8084.231997960184, 8106.513609183467, 8120.228578285053, 8195.754127376189, 898.725888603969, 942.5711301357866, 1016.8118898003893, 1020.8723909511311, 1048.3605000949415, 27741.0, 27925.0, 28130.0, 28157.155285341472, 28207.71792282092, 1052.594751020847, 1117.5585643670704, 1153.5097583527136, 1153.5674122204173, 1184.709746112208, 14883.553493395215, 14904.329305181293, 14982.250887455584, 15124.092554446768, 15131.0, 303312.0, 306226.0, 306782.0, 307211.0, 307572.0, 51005.74497127491, 51033.74483127635, 51055.48944510507, 51168.74415627898, 51513.7424312876, 1329.7672907241194, 1330.2417621955392, 1334.7664158772177, 1337.6187786481, 1341.8456877459023, 26615.60076598814, 27577.0, 28017.719822802326, 28138.71861281361, 28177.295567610152, 45813.0, 46174.53825461702, 46195.30707039464, 46263.306050408595, 46287.0, 288038.0, 288877.33419994, 290529.0, 290969.0, 291497.0, 27336.316592085357, 27521.724782751917, 31181.0, 31418.528722069645, 31766.523502147025, 37792.62207377891, 38183.809080954416, 38559.42160867645, 38566.0, 38903.61096389113, 32496.83751581227, 32526.674733253312, 32827.34345313128, 32968.0, 40026.79986600048, 34417.655823442445, 36000.09999750027, 36299.0, 39816.60183398129, 40472.79763601163, 35761.82119089492, 35811.462828057076, 36204.27591448209, 36401.0, 36591.0, 32117.35765284728, 32763.508547371333, 33659.831700841336, 33704.66295337015, 37017.44473832948, 25504.74495255098, 25877.0, 25967.870160649833, 26077.478450430506, 26157.60763588586], "unit": "ms", "name": "ext.html", "value": 18706.304941527513}, {"lowerIsBetter": false, "replicates": [362.1724359837771, 365.85914422947167, 366.2400518923235, 367.602988772126, 368.18079772506195, 14566.563003109924, 14708.0, 16459.83540164598, 16779.0, 17338.306467741277, 15974.840251597481, 16515.917420412912, 16819.15904204791, 16943.32226710933, 17063.488095357126, 4912.287718280847, 5025.547700706936, 5026.623003274751, 5028.597712183035, 5031.4465408805, 3751.531058617673, 3829.3107240696804, 4992.126377883874, 5019.623528235379, 5409.134538473845, 5500.339959204901, 5540.058190107691, 5557.166425036236, 5557.944420555783, 5560.360558535759, 5384.865378365553, 5520.447955204468, 5526.309211348582, 5537.778488860441, 5543.473370029841, 5333.786648534054, 5335.546478549328, 5337.11937530307, 5343.251944727741, 5350.839474815762, 12449.93775031119, 13214.273214973173, 13231.338433078308, 13249.801252981213, 13250.86749132506, 1980.7524059492564, 1995.2118913029271, 1998.8001199879895, 2006.6388050151113, 2045.836333093349, 9493.193078588329, 9922.652707155286, 10644.520996555173, 10986.450677466095, 13243.139195952232, 1798.8291112344436, 1814.528222662104, 1825.0509734937891, 1836.5041438811445, 1857.619188066443, 58731.41268587302, 59487.70256148691, 59554.0, 59862.40137598612, 60850.695746520985, 9085.36402451822, 9195.862062069074, 9270.563062725289, 9281.628734850665, 9306.115918987685, 11905.0, 11931.701707457383, 11936.164468487295, 11943.223690460267, 11960.40197990097, 6818.045473633695, 6894.413974812097, 6967.059446974695, 7029.789106326818, 7092.964535177394, 6587.835304117435, 6778.932210677929, 6858.725650974005, 6862.691178896962, 6862.862742745217, 3955.3275943089743, 4189.308764053958, 4193.098483825992, 4362.934555981663, 4388.758618276025, 1602.238936505174, 1667.2747354900414, 1688.560974146706, 1739.8956062636282, 1785.7232129019762, 777.7200207925142, 841.4656692999989, 842.587132305166, 894.0121166111484, 921.3872774604947, 15069.47256846005, 15883.52349429496, 16373.263203155886, 16665.500034998968, 17266.740998885027, 854.7948492361788, 875.1205038935828, 882.9161229683169, 940.6331530703031, 959.040959040959, 9522.428654280766, 9562.952185239168, 9896.109350158376, 10083.949580252052, 10147.0, 471720.0, 475486.0, 476114.0, 484688.0, 488050.0, 70217.0, 70987.0, 71678.64160679163, 72247.63876180585, 73681.26318736852, 1146.6273461125168, 1148.190525679394, 1200.5017917564287, 1206.1436380170003, 1218.7318789866215, 14978.0, 15099.245037747849, 15120.0, 15291.158986255863, 15320.233988300317, 33803.83098084494, 33961.320773584885, 34037.149071273416, 34186.48720269248, 34371.14072148217, 43694.56305437032, 43999.340009899235, 44201.0, 44254.55745442504, 46757.0, 9229.953850230706, 9241.260699144186, 9445.433274003582, 9813.067758562926, 9820.754481138028, 11516.596919107791, 11554.960053595218, 11898.643040708792, 16652.333906644082, 16707.0, 11565.710857228636, 12039.578614748441, 13323.733525329246, 13704.0, 13951.441942322193, 13360.599182024554, 13717.108387954751, 13814.723705525632, 14171.149731016172, 14338.641533961734, 11162.832557511807, 11377.188641805087, 11429.59996400122, 14065.929670351583, 14334.784978225127, 9199.632014719336, 9208.355415120877, 9261.073892610684, 9300.302477314364, 9384.108509691841, 10015.449150296803, 10191.94904025475, 10879.728006799576, 14242.501512447014, 14396.496122635657], "unit": "ms", "name": "jquery.html", "value": 8360.295514455187}, {"lowerIsBetter": false, "replicates": [1346.9393877275522, 1691.636298195888, 1730.255989924332, 1755.4733579926024, 1770.6812773700728, 6890.0, 7279.526830755997, 7371.963140184292, 7376.299251571092, 7376.668049937753, 7553.0, 7658.195889431613, 7680.846383072349, 7683.270089341504, 7688.5771282579435, 1957.2562426277993, 1989.8905560194185, 2200.0759680934048, 2260.581792368413, 2283.3492454650427, 2312.2600767754325, 2312.4796920692793, 2316.5019520803025, 2325.7092863392077, 2326.441654003044, 2228.7882651148116, 2280.1107568048474, 2281.349815302639, 2282.0643536150183, 2284.7486776454575, 1978.1296229658976, 2019.6869485229813, 2163.069879951628, 2203.5703037907615, 2207.381933058746, 2211.6682497625325, 2234.4078819112947, 2253.4929640830846, 2260.4348912771807, 2261.9886900565393, 7380.963095184544, 7428.2571742825285, 7428.888566671504, 7433.628318584103, 7435.776926692208, 4663.0, 4769.070031343855, 4769.833055843063, 4781.091592597395, 4782.665213435061, 3087.845607719605, 3111.4088323218743, 3153.2589841387257, 3215.5015972524297, 3232.305054413289, 997.0876647867193, 998.6354980432089, 1031.6750223679592, 1038.5897570459701, 1095.5179720922768, 10497.265191436603, 10534.104601108838, 10543.367397956146, 10546.419946902917, 10555.155587552978, 4142.875713728593, 4243.151369726067, 4277.871663850089, 4291.0559676871035, 4294.227039132986, 9083.591238394289, 9086.909130908607, 9101.180893719596, 9112.453252804853, 9120.224780893699, 4736.668433209642, 4739.099571081483, 4771.284307353855, 4776.379070720854, 4777.092352453023, 4272.6154646082, 4284.400183974246, 4310.137972405531, 4316.266234740102, 4316.870493885189, 3686.299603075407, 3724.6834019108137, 3725.4411838224482, 3746.7751934883995, 3776.4335349697217, 1194.8745381734793, 1194.9163558550817, 1196.0252394298618, 1198.4786617821276, 1199.6880810989205, 972.5866506734751, 1001.6994901529512, 1202.8797120288077, 1285.0875878126635, 1312.534050412109, 6263.123162757218, 7296.087989001375, 7504.62476876165, 7511.248875112555, 7516.549007059594, 586.8826234753067, 586.906095024794, 587.3715124816406, 596.0046721974313, 601.0623427453187, 5733.226014488074, 5753.1370294456165, 5764.596478246566, 5821.301443826683, 5822.748109156551, 9082.727518174466, 9237.07629237071, 9237.30720195988, 9274.0, 9276.72169834906, 9195.77010574741, 9210.677626283048, 9214.769630759285, 9215.677451289173, 9242.72271831846, 6954.365724054843, 7153.248908864494, 7213.819654508679, 7219.74730884427, 7222.711091556279, 7133.3936615388275, 7172.713091476283, 7231.891521627285, 7239.203687594255, 7248.855022899407, 8042.557659328793, 8182.672693092448, 8240.21717936795, 8289.005319361715, 8298.70954516589, 8169.591520424074, 8339.416240863082, 8469.703560375357, 8478.406511544134, 8480.74557763268, 6569.37590928861, 6634.635095069818, 6638.502112341497, 6641.933580664131, 6646.9335306648245, 7192.1369435665965, 7246.673899674633, 7251.492395532473, 7260.600666963368, 7269.890951635835, 6675.866482670416, 6797.1843378794865, 6857.965710171417, 6927.792166235021, 6947.478939079489, 6391.6804159792755, 6448.645324507197, 6472.838179045561, 6497.805065848032, 6632.568883022588, 6023.45788879003, 6414.775482858077, 6720.227173875067, 6740.090087838079, 6799.2520822708475, 6160.9383906160365, 6166.290876549254, 6200.689965501617, 6203.193584834124, 6209.0, 6414.390632889868, 6440.742370305135, 6444.516661250331, 6445.065465507381, 6455.741770329134], "unit": "ms", "name": "mootools.html", "value": 4355.349483162736}, {"lowerIsBetter": false, "replicates": [321.20021147343124, 324.83920459372615, 325.2746375582451, 338.7577881814502, 343.1027862140502, 6032.0951857221435, 6077.756889724411, 6136.846578835532, 6156.6306021638675, 6184.165137706408, 5883.058710606304, 6037.849053773658, 6080.635161890279, 6090.878182436349, 6104.206453161094, 4675.812967481296, 4676.321933319675, 4679.181143299926, 4679.204535229019, 4690.4371475422995, 4466.397036400093, 4579.656525760564, 4592.425946756655, 4682.882927926795, 4701.036287561059, 4626.907461850761, 4632.050429661911, 4636.791344389494, 4642.628589712832, 4653.7440440775745, 4625.283081122415, 4627.0, 4627.722336659811, 4633.4439867215815, 4647.581717645395, 4063.288924438241, 4071.307877660805, 4071.470708807866, 4084.7549147050977, 4094.2220978014084, 5694.629849059798, 5809.390014048548, 5811.738471768781, 5817.243758311435, 5835.0, 5411.512963833274, 5412.269343638598, 5415.810446634388, 5424.674519528841, 5428.891422171574, 6181.81454556364, 6452.516061295421, 6453.774117905851, 6457.12828768115, 6460.289368169498, 4397.406350142754, 4447.0, 4534.841280555164, 4537.750423726727, 4542.091581683677, 6641.302663220341, 6681.231658359302, 6748.865022699617, 6756.864862702768, 6758.459323254128, 4681.157391669532, 4685.1332503486965, 4686.718796872198, 4690.249560070372, 4690.695104818176, 4668.39310889589, 4745.501722319176, 4746.454157771831, 4748.406449193851, 4757.072370887713, 5432.837014889559, 5440.238366628675, 5446.2375267462585, 5446.291982042309, 5457.2359869618285, 6554.4756419487285, 6556.950887858015, 6559.672016399161, 6564.86870262592, 6573.769918052845, 1652.5455499737668, 1686.055808747081, 1689.1469807747255, 1690.8055573609192, 1695.3981336625568, 1045.6497073480318, 1087.2443651662177, 1088.0262165361958, 1096.0683419093866, 1136.8578927634046, 6130.969345153246, 6141.232345956755, 6143.539234557426, 6150.569460137837, 6191.0, 6614.107095542136, 6664.266930637626, 6671.366220209073, 6672.866542669217, 6676.499262555328, 6209.379062093845, 6219.471344935731, 6262.248530176317, 6262.6868656566985, 6280.340564240781, 3668.706503479769, 3699.463577781207, 3701.481792549045, 3703.851845926187, 3711.498947642088, 6898.758543450955, 7067.858642827115, 7072.929270707227, 7073.469489788286, 7083.6458177090935, 6857.348551887562, 6971.825704357431, 7004.054452648929, 7006.159260888726, 7007.334303241184, 7037.437005039687, 7038.753643622551, 7044.084269044992, 7047.471439641945, 7053.188883278489, 6518.967405162944, 6607.702653380706, 6633.2371777246235, 6777.525573209828, 6780.660966951534, 6649.634270114997, 6651.933480665131, 6651.966740166268, 6679.398854103154, 6723.630200339028, 7026.227115017242, 7029.613371264425, 7030.367266945999, 7035.507514473938, 7041.366277035091, 4390.626796722315, 4493.887652808706, 4508.120916421266, 4581.175388430114, 4628.67599268048, 6738.460923126237, 6760.425363843931, 6763.526553141233, 6764.763233286812, 6766.2218844831505, 6547.148870646785, 6556.541042127196, 6560.901586476111, 6568.638724870178, 6584.144061272004, 6498.187726534184, 6547.181602299713, 6549.410553050248, 6550.541462097607, 6552.934470655233, 6422.293547709654, 6430.164078669743, 6433.0, 6437.130987316839, 6444.548881578245, 6527.836804079936, 6559.376859198369, 6564.310747371457, 6575.112359831362, 6577.276499585138, 6310.148130002391, 6414.390632889868, 6467.967660161669, 6477.1579694639395, 6492.837679058061], "unit": "ms", "name": "prototype.html", "value": 4907.423147252841}, {"lowerIsBetter": false, "replicates": [787.0681710627915, 832.2759199496439, 843.8818565400845, 846.3694547562067, 858.9656413743451, 13189.934050329759, 13478.46086156555, 13494.595162145128, 13503.32483375831, 13527.932360338185, 12383.380830958462, 12386.194897331667, 12399.56601518947, 12400.93799531001, 12441.253524788519, 665.7703092433103, 788.5899332347191, 803.441608082383, 803.4817542684993, 803.6102490292203, 669.3473862983576, 788.5584072919155, 807.8828569857367, 808.0, 808.216030450465, 836.4019725895984, 838.4927119092953, 847.3009766942297, 847.3475423923575, 847.682119205298, 668.358375959075, 680.9897851532231, 835.6657337065192, 837.8408102460544, 838.5262326785378, 581.5812614917253, 591.7721677154327, 592.0911400999488, 592.2744637818638, 593.1784478497269, 12484.938780203694, 12516.123871329011, 12547.0, 12577.24536527802, 12674.302913339763, 11452.828207576893, 12258.81611775824, 12265.754684906342, 12500.0, 12690.936545317214, 9849.16282116021, 9853.50732463381, 9906.455144967023, 9932.322658453679, 10001.0, 3550.840212190458, 3622.0, 3648.1609229877013, 3678.2643471305846, 3719.3863012602887, 44294.77852610716, 44437.3334399981, 44787.32819007685, 44832.55167448316, 44854.0, 8864.64541418336, 9021.413608115452, 9344.177885312434, 9374.343795934219, 9408.499566348655, 17903.820961790476, 17992.91003545, 17998.280068797103, 18073.638527229647, 18087.0, 6979.4765392595755, 7347.522411043372, 7452.956586077953, 7453.180150183475, 7592.696292148363, 4058.0, 4175.15173790816, 4180.623743863006, 4192.748435093904, 4199.097194103282, 3068.6010818593886, 3118.7349075328398, 3382.6279109297957, 3443.070370999816, 3443.6728510791436, 613.6608830778052, 620.6493331267819, 627.2848952194502, 629.9086632438363, 632.2697284636253, 591.4233622218388, 598.8172614289186, 614.1862032806549, 619.4610688700859, 625.6402568523117, 8228.136045715113, 8523.147685231552, 8560.571971401405, 8756.343274254456, 9242.306826988002, 629.5404354821006, 634.2579182356653, 642.1106767127562, 658.3942772649174, 668.729164688302, 3920.5295364555864, 3936.4685767421033, 4019.8392064317686, 4019.9397009044887, 4090.365993271048, 52248.738756305975, 52507.0, 52559.0, 53133.0, 53903.46096539063, 47372.0, 48868.75565622149, 49074.263886041736, 49305.75347123241, 49327.0, 43741.34387984183, 44094.0, 44161.558384416385, 44270.335944960854, 44623.0, 7736.497127686683, 7818.218178182136, 7944.404169687181, 8014.8397032057865, 8020.959895200486, 33253.33493330168, 33586.16034599154, 34352.656473434945, 34968.10446537538, 36486.0, 43778.12443751171, 43886.463973760765, 44273.77863110664, 44329.55670443254, 44495.0, 11088.501017454395, 11115.0, 11169.888301116885, 11246.212765106364, 11469.31184128955, 12350.197237179555, 12692.746145077232, 12733.61799146027, 13301.268430236043, 13306.933465332611, 10172.643957461454, 10677.51951162184, 10690.358578485315, 10752.40861752611, 11063.778724425305, 11238.438078095898, 11502.53989840397, 11873.643790686294, 12064.0, 12212.511499539918, 11590.420478976186, 11794.351310677652, 11927.10546708983, 12021.054841563873, 12325.075619328407, 9388.248940084914, 9521.809563808547, 9732.75668108303, 9834.459104749307, 9862.309638325249, 9143.0799532099, 9147.725568232963, 9266.536673166449, 10110.898891010997, 10133.189344852246], "unit": "ms", "name": "yui.html", "value": 6188.729964094926}], "name": "dromaeo_css", "value": 6928.7735587029465}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 112.0, 105.0, 111.0, 111.0, 111.0, 102.0, 112.0, 114.0, 110.0], "unit": "ms", "name": "ai-astar", "value": 110.0}, {"lowerIsBetter": true, "replicates": [154.0, 124.0, 151.0, 167.0, 125.0, 146.0, 149.0, 125.0, 169.0, 154.0], "unit": "ms", "name": "audio-beat-detection", "value": 146.4}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 161.0, 160.0, 161.0, 161.0, 159.0, 163.0, 162.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 161.2}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 87.0, 93.0, 73.0, 71.0, 71.0, 134.0, 92.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 83.7}, {"lowerIsBetter": true, "replicates": [90.0, 91.0, 137.0, 91.0, 91.0, 91.0, 143.0, 91.0, 92.0, 140.0], "unit": "ms", "name": "audio-oscillator", "value": 105.7}, {"lowerIsBetter": true, "replicates": [111.0, 111.0, 110.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 145.0, 146.0, 147.0, 146.0, 145.0, 145.0, 145.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.5}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 95.0, 96.0, 98.0, 96.0, 96.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [59.0, 58.0, 57.0, 58.0, 59.0, 59.0, 57.0, 65.0, 55.0, 55.0], "unit": "ms", "name": "json-parse-financial", "value": 58.2}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 69.0, 68.0, 69.0, 69.0, 70.0, 69.0, 69.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.8}, {"lowerIsBetter": true, "replicates": [84.0, 85.0, 84.0, 85.0, 93.0, 84.0, 85.0, 84.0, 86.0, 85.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.5}, {"lowerIsBetter": true, "replicates": [128.0, 140.0, 115.0, 128.0, 129.0, 117.0, 123.0, 125.0, 126.0, 120.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 125.1}, {"lowerIsBetter": true, "replicates": [140.0, 152.0, 154.0, 154.0, 154.0, 145.0, 157.0, 149.0, 146.0, 147.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 149.8}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 67.0, 68.0, 67.0, 70.0, 69.0, 65.0, 65.0, 67.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 67.3}], "name": "kraken", "value": 1512.5}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [163.47882949158085], "unit": "score", "name": "Richards", "value": 215.94233399999993}, {"lowerIsBetter": false, "replicates": [194.47685725398676], "unit": "score", "name": "DeltaBlue", "value": 339.9787560000001}, {"lowerIsBetter": false, "replicates": [285.143997718848], "unit": "score", "name": "Encrypt", "value": 933.4967669999996}, {"lowerIsBetter": false, "replicates": [5040.201005025126], "unit": "score", "name": "Decrypt", "value": 52.81158424725827}, {"lowerIsBetter": false, "replicates": [1108.6474501108648], "unit": "score", "name": "RayTrace", "value": 667.4700779999998}, {"lowerIsBetter": false, "replicates": [777.6049766718507], "unit": "score", "name": "Earley", "value": 857.0714179999998}, {"lowerIsBetter": false, "replicates": [12144.578313253012], "unit": "score", "name": "Boyer", "value": 54.87740972222223}, {"lowerIsBetter": false, "replicates": [25897.4358974359], "unit": "score", "name": "RegExp", "value": 35.17664851485149}, {"lowerIsBetter": false, "replicates": [660.1178781925344], "unit": "score", "name": "Splay", "value": 123.44916369047621}, {"lowerIsBetter": false, "replicates": [4854.368932038835], "unit": "score", "name": "NavierStokes", "value": 305.7040000000001}], "name": "v8_7", "value": 20872.522250495065}]} 07:14:10 INFO - RETURN: dromaeo_css: 6928.77 07:14:10 INFO - RETURN: kraken: 1512.50 07:14:10 INFO - RETURN: v8_7: 20872.52 07:14:10 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,35]]", "result": "20872.52"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1512.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6928.77"}}} 07:14:10 INFO - Return code: 0 07:14:10 INFO - # TBPL SUCCESS # 07:14:10 INFO - Running post-action listener: _resource_record_post_action 07:14:10 INFO - Running post-run listener: _resource_record_post_run 07:14:11 INFO - Total resource usage - Wall time: 1226s; CPU: 13.0%; Read bytes: 0; Write bytes: 506540032; Read time: 0; Write time: 557632 07:14:11 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 193675264; Read time: 0; Write time: 254856 07:14:11 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 0; Write bytes: 266948608; Read time: 0; Write time: 137328 07:14:11 INFO - Running post-run listener: _upload_blobber_files 07:14:11 INFO - Blob upload gear active. 07:14:11 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 07:14:11 INFO - Copying logs to upload dir... 07:14:11 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1253.749410 ========= master_lag: 0.45 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2015-11-23 07:14:09.862363) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-23 07:14:09.866356) ========= 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=edca6ca23558fe0608d91a4e00000196-1448290337.102161-1359648957 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/tN1Vpl1qTAWhMzTte2gNJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010012 build_url: 'https://queue.taskcluster.net/v1/task/tN1Vpl1qTAWhMzTte2gNJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.05 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-23 07:14:09.921832) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 07:14:09.922190) ========= 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=edca6ca23558fe0608d91a4e00000196-1448290337.102161-1359648957 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004488 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 07:14:09.974114) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 07:14:09.974643) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 07:14:09.975138) ========= ========= Total master_lag: 0.66 =========