builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-027 starttime: 1447996775.48 results: success (0) buildid: 20151119193324 builduid: 6dad6250e12c4fa9b96484f60fc8d606 revision: 1946937e23afd1e6783d2f83737b074fa680c9a8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-19 21:19:35.480172) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-19 21:19:35.480556) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-19 21:19:35.480840) ========= 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=447a3abc0420b6a47dd38cba000001bf-1447996238.572703-268325781 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006488 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-19 21:19:35.526565) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-19 21:19:35.526832) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-19 21:19:35.558376) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 21:19:35.558643) ========= 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=447a3abc0420b6a47dd38cba000001bf-1447996238.572703-268325781 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004781 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 21:19:35.615312) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-19 21:19:35.615580) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-19 21:19:35.615929) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 21:19:35.616218) ========= 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=447a3abc0420b6a47dd38cba000001bf-1447996238.572703-268325781 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-19 21:19:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 38.3M=0s 2015-11-19 21:19:36 (38.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.182868 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 21:19:35.814928) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 21:19:35.815232) ========= 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=447a3abc0420b6a47dd38cba000001bf-1447996238.572703-268325781 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020008 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 21:19:35.865585) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 21:19:35.865892) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 1946937e23afd1e6783d2f83737b074fa680c9a8 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 1946937e23afd1e6783d2f83737b074fa680c9a8 --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=447a3abc0420b6a47dd38cba000001bf-1447996238.572703-268325781 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-19 21:19:36,244 truncating revision to first 12 chars 2015-11-19 21:19:36,244 Setting DEBUG logging. 2015-11-19 21:19:36,244 attempt 1/10 2015-11-19 21:19:36,244 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/1946937e23af?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-19 21:19:36,500 unpacking tar archive at: mozilla-inbound-1946937e23af/testing/mozharness/ program finished with exit code 0 elapsedTime=0.565404 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 21:19:36.444887) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-19 21:19:36.445166) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-19 21:19:36.454747) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-19 21:19:36.454987) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-19 21:19:36.455362) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2015-11-19 21:19:36.455634) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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', 'Mozilla-Inbound', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=447a3abc0420b6a47dd38cba000001bf-1447996238.572703-268325781 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:19:36 INFO - MultiFileLogger online at 20151119 21:19:36 in /builds/slave/test-pgo 21:19:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 21:19:36 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 21:19:36 INFO - {'append_to_log': False, 21:19:36 INFO - 'base_work_dir': '/builds/slave/test-pgo', 21:19:36 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 21:19:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 21:19:36 INFO - 'branch': 'Mozilla-Inbound', 21:19:36 INFO - 'buildbot_json_path': 'buildprops.json', 21:19:36 INFO - 'config_files': ('talos/linux_config.py',), 21:19:36 INFO - 'default_actions': ('clobber', 21:19:36 INFO - 'read-buildbot-config', 21:19:36 INFO - 'download-and-extract', 21:19:36 INFO - 'populate-webroot', 21:19:36 INFO - 'create-virtualenv', 21:19:36 INFO - 'install', 21:19:36 INFO - 'run-tests'), 21:19:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:19:36 INFO - 'download_minidump_stackwalk': True, 21:19:36 INFO - 'download_symbols': 'ondemand', 21:19:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:19:36 INFO - 'tooltool.py': '/tools/tooltool.py', 21:19:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:19:36 INFO - '/tools/misc-python/virtualenv.py')}, 21:19:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:19:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:19:36 INFO - 'installer_path': 'installer.exe', 21:19:36 INFO - 'log_level': 'info', 21:19:36 INFO - 'log_name': 'talos', 21:19:36 INFO - 'log_to_console': True, 21:19:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:19:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:19:36 INFO - 'opt_config_files': (), 21:19:36 INFO - 'pip_index': False, 21:19:36 INFO - 'sps_profile': False, 21:19:36 INFO - 'sps_profile_interval': 0, 21:19:36 INFO - 'suite': 'dromaeojs', 21:19:36 INFO - 'system_bits': '64', 21:19:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:19:36 INFO - 'title': 'talos-linux64-ix-027', 21:19:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:19:36 INFO - 'use_talos_json': True, 21:19:36 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 21:19:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:19:36 INFO - 'work_dir': 'build'} 21:19:36 INFO - ##### 21:19:36 INFO - ##### Running clobber step. 21:19:36 INFO - ##### 21:19:36 INFO - Running pre-action listener: _resource_record_pre_action 21:19:36 INFO - Running main action method: clobber 21:19:36 INFO - rmtree: /builds/slave/test-pgo/build 21:19:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 21:19:37 INFO - Running post-action listener: _resource_record_post_action 21:19:37 INFO - ##### 21:19:37 INFO - ##### Running read-buildbot-config step. 21:19:37 INFO - ##### 21:19:37 INFO - Running pre-action listener: _resource_record_pre_action 21:19:37 INFO - Running main action method: read_buildbot_config 21:19:37 INFO - Using buildbot properties: 21:19:37 INFO - { 21:19:37 INFO - "properties": { 21:19:37 INFO - "buildnumber": 1284, 21:19:37 INFO - "product": "firefox", 21:19:37 INFO - "script_repo_revision": "production", 21:19:37 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 21:19:37 INFO - "repository": "", 21:19:37 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 21:19:37 INFO - "buildid": "20151119193324", 21:19:37 INFO - "slavename": "talos-linux64-ix-027", 21:19:37 INFO - "pgo_build": "True", 21:19:37 INFO - "basedir": "/builds/slave/test-pgo", 21:19:37 INFO - "project": "", 21:19:37 INFO - "platform": "ubuntu64_hw", 21:19:37 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 21:19:37 INFO - "slavebuilddir": "test", 21:19:37 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 21:19:37 INFO - "branch": "mozilla-inbound", 21:19:37 INFO - "repo_path": "integration/mozilla-inbound", 21:19:37 INFO - "stage_platform": "linux64-pgo", 21:19:37 INFO - "builduid": "6dad6250e12c4fa9b96484f60fc8d606", 21:19:37 INFO - "revision": "1946937e23afd1e6783d2f83737b074fa680c9a8" 21:19:37 INFO - }, 21:19:37 INFO - "sourcestamp": { 21:19:37 INFO - "repository": "", 21:19:37 INFO - "hasPatch": false, 21:19:37 INFO - "project": "", 21:19:37 INFO - "branch": "mozilla-inbound-linux64-pgo-talos", 21:19:37 INFO - "changes": [ 21:19:37 INFO - { 21:19:37 INFO - "category": null, 21:19:37 INFO - "files": [ 21:19:37 INFO - { 21:19:37 INFO - "url": null, 21:19:37 INFO - "name": "https://queue.taskcluster.net/v1/task/-aDrMBVKT8Ss3r1ume4yzw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 21:19:37 INFO - } 21:19:37 INFO - ], 21:19:37 INFO - "repository": "", 21:19:37 INFO - "rev": "1946937e23afd1e6783d2f83737b074fa680c9a8", 21:19:37 INFO - "who": "sendchange", 21:19:37 INFO - "when": 1447996715, 21:19:37 INFO - "number": 6686864, 21:19:37 INFO - "comments": "", 21:19:37 INFO - "project": "", 21:19:37 INFO - "at": "Thu 19 Nov 2015 21:18:35", 21:19:37 INFO - "branch": "mozilla-inbound-linux64-pgo-talos", 21:19:37 INFO - "revlink": "", 21:19:37 INFO - "properties": [ 21:19:37 INFO - [ 21:19:37 INFO - "buildid", 21:19:37 INFO - "20151119193324", 21:19:37 INFO - "Change" 21:19:37 INFO - ], 21:19:37 INFO - [ 21:19:37 INFO - "builduid", 21:19:37 INFO - "6dad6250e12c4fa9b96484f60fc8d606", 21:19:37 INFO - "Change" 21:19:37 INFO - ], 21:19:37 INFO - [ 21:19:37 INFO - "pgo_build", 21:19:37 INFO - "True", 21:19:37 INFO - "Change" 21:19:37 INFO - ] 21:19:37 INFO - ], 21:19:37 INFO - "revision": "1946937e23afd1e6783d2f83737b074fa680c9a8" 21:19:37 INFO - } 21:19:37 INFO - ], 21:19:37 INFO - "revision": "1946937e23afd1e6783d2f83737b074fa680c9a8" 21:19:37 INFO - } 21:19:37 INFO - } 21:19:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/-aDrMBVKT8Ss3r1ume4yzw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 21:19:37 INFO - Running post-action listener: _resource_record_post_action 21:19:37 INFO - ##### 21:19:37 INFO - ##### Running download-and-extract step. 21:19:37 INFO - ##### 21:19:37 INFO - Running pre-action listener: _resource_record_pre_action 21:19:37 INFO - Running main action method: download_and_extract 21:19:37 INFO - mkdir: /builds/slave/test-pgo/build/tests 21:19:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:19:37 INFO - https://queue.taskcluster.net/v1/task/-aDrMBVKT8Ss3r1ume4yzw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 21:19:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-aDrMBVKT8Ss3r1ume4yzw/artifacts/public/build/test_packages.json 21:19:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-aDrMBVKT8Ss3r1ume4yzw/artifacts/public/build/test_packages.json 21:19:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-aDrMBVKT8Ss3r1ume4yzw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 21:19:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-aDrMBVKT8Ss3r1ume4yzw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 21:19:43 INFO - Downloaded 1302 bytes. 21:19:43 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 21:19:43 INFO - Using the following test package requirements: 21:19:43 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 21:19:43 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:19:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:19:43 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:19:43 INFO - u'jsshell-linux-x86_64.zip'], 21:19:43 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:19:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:19:43 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 21:19:43 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:19:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:19:43 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:19:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:19:43 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:19:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:19:43 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 21:19:43 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:19:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:19:43 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:19:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:19:43 INFO - https://queue.taskcluster.net/v1/task/-aDrMBVKT8Ss3r1ume4yzw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:19:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-aDrMBVKT8Ss3r1ume4yzw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:19:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-aDrMBVKT8Ss3r1ume4yzw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:19:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-aDrMBVKT8Ss3r1ume4yzw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:19:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-aDrMBVKT8Ss3r1ume4yzw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:19:56 INFO - Downloaded 22530279 bytes. 21:19:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 21:19:56 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:19:56 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 21:19:57 INFO - Return code: 0 21:19:57 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 21:19:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:19:57 INFO - https://queue.taskcluster.net/v1/task/-aDrMBVKT8Ss3r1ume4yzw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:19:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-aDrMBVKT8Ss3r1ume4yzw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:19:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-aDrMBVKT8Ss3r1ume4yzw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:19:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-aDrMBVKT8Ss3r1ume4yzw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:19:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-aDrMBVKT8Ss3r1ume4yzw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:20:06 INFO - Downloaded 22530279 bytes. 21:20:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 21:20:06 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:20:06 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 21:20:07 INFO - Return code: 0 21:20:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:20:07 INFO - https://queue.taskcluster.net/v1/task/-aDrMBVKT8Ss3r1ume4yzw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:20:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-aDrMBVKT8Ss3r1ume4yzw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 21:20:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-aDrMBVKT8Ss3r1ume4yzw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 21:20:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-aDrMBVKT8Ss3r1ume4yzw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 21:20:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-aDrMBVKT8Ss3r1ume4yzw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:20:08 INFO - Downloaded 11130997 bytes. 21:20:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 21:20:08 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 21:20:08 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 21:20:09 INFO - Return code: 0 21:20:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:20:09 INFO - https://queue.taskcluster.net/v1/task/-aDrMBVKT8Ss3r1ume4yzw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:20:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-aDrMBVKT8Ss3r1ume4yzw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 21:20:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-aDrMBVKT8Ss3r1ume4yzw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 21:20:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-aDrMBVKT8Ss3r1ume4yzw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 21:20:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-aDrMBVKT8Ss3r1ume4yzw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 21:20:10 INFO - Downloaded 57345678 bytes. 21:20:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/-aDrMBVKT8Ss3r1ume4yzw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 21:20:10 INFO - mkdir: /builds/slave/test-pgo/properties 21:20:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 21:20:10 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 21:20:10 INFO - Contents: 21:20:10 INFO - build_url:https://queue.taskcluster.net/v1/task/-aDrMBVKT8Ss3r1ume4yzw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 21:20:10 INFO - Running post-action listener: _resource_record_post_action 21:20:10 INFO - Running post-action listener: set_extra_try_arguments 21:20:10 INFO - ##### 21:20:10 INFO - ##### Running populate-webroot step. 21:20:10 INFO - ##### 21:20:10 INFO - Running pre-action listener: _resource_record_pre_action 21:20:10 INFO - Running main action method: populate_webroot 21:20:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:20:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:20:10 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 21:20:10 INFO - '../fennec_ids.txt'], 21:20:10 INFO - 'tests': ['tcheck2']}, 21:20:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:20:10 INFO - '--tppagecycles', 21:20:10 INFO - '7'], 21:20:10 INFO - 'tests': ['tsvgm']}}, 21:20:10 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 21:20:10 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 21:20:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:20:10 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:20:10 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 21:20:10 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:20:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:20:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:20:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:20:10 INFO - 'talos_options': ['--e10s'], 21:20:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:20:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:20:10 INFO - 'tests': ['damp', 'tps']}, 21:20:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:20:10 INFO - 'talos_options': ['--e10s'], 21:20:10 INFO - 'tests': ['damp', 'tps']}, 21:20:10 INFO - 'g3': {'tests': ['dromaeo_dom']}, 21:20:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:20:10 INFO - 'other': {'tests': ['a11yr', 21:20:10 INFO - 'ts_paint', 21:20:10 INFO - 'tpaint', 21:20:10 INFO - 'sessionrestore', 21:20:10 INFO - 'sessionrestore_no_auto_restore']}, 21:20:10 INFO - 'other-e10s': {'talos_options': ['--e10s'], 21:20:10 INFO - 'tests': ['a11yr', 21:20:10 INFO - 'ts_paint', 21:20:10 INFO - 'tpaint', 21:20:10 INFO - 'sessionrestore', 21:20:10 INFO - 'sessionrestore_no_auto_restore']}, 21:20:10 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 21:20:10 INFO - 'tests': ['a11yr', 21:20:10 INFO - 'ts_paint', 21:20:10 INFO - 'tpaint', 21:20:10 INFO - 'sessionrestore', 21:20:10 INFO - 'sessionrestore_no_auto_restore']}, 21:20:10 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 21:20:10 INFO - 'tests': ['a11yr', 21:20:10 INFO - 'ts_paint', 21:20:10 INFO - 'tpaint', 21:20:10 INFO - 'sessionrestore', 21:20:10 INFO - 'sessionrestore_no_auto_restore']}, 21:20:10 INFO - 'other_l64': {'tests': ['a11yr', 21:20:10 INFO - 'ts_paint', 21:20:10 INFO - 'tpaint', 21:20:10 INFO - 'sessionrestore', 21:20:10 INFO - 'sessionrestore_no_auto_restore']}, 21:20:10 INFO - 'other_nol64': {'tests': ['a11yr', 21:20:10 INFO - 'ts_paint', 21:20:10 INFO - 'tpaint', 21:20:10 INFO - 'sessionrestore', 21:20:10 INFO - 'sessionrestore_no_auto_restore']}, 21:20:10 INFO - 'svgr': {'tests': ['tsvgx', 21:20:10 INFO - 'tsvgr_opacity', 21:20:10 INFO - 'tart', 21:20:10 INFO - 'tscrollx', 21:20:10 INFO - 'cart']}, 21:20:10 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 21:20:10 INFO - 'tests': ['tsvgx', 21:20:10 INFO - 'tsvgr_opacity', 21:20:10 INFO - 'tart', 21:20:10 INFO - 'tscrollx', 21:20:10 INFO - 'cart']}, 21:20:10 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:20:10 INFO - 'tests': ['tp5o']}, 21:20:10 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:20:10 INFO - 'talos_options': ['--e10s'], 21:20:10 INFO - 'tests': ['tp5o']}, 21:20:10 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:20:10 INFO - 'talos_options': ['--xperf_path', 21:20:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:20:10 INFO - 'tests': ['tp5n']}, 21:20:10 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:20:10 INFO - 'talos_options': ['--e10s', 21:20:10 INFO - '--xperf_path', 21:20:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:20:10 INFO - 'tests': ['tp5n']}}, 21:20:10 INFO - 'talos.zip': {'path': '', 21:20:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:20:10 INFO - Running post-action listener: _resource_record_post_action 21:20:10 INFO - ##### 21:20:10 INFO - ##### Running create-virtualenv step. 21:20:10 INFO - ##### 21:20:10 INFO - Running pre-action listener: _resource_record_pre_action 21:20:10 INFO - Running main action method: create_virtualenv 21:20:10 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 21:20:10 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 21:20:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 21:20:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:20:10 INFO - Using real prefix '/usr' 21:20:10 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 21:20:11 INFO - Installing distribute.............................................................................................................................................................................................done. 21:20:13 INFO - Installing pip.................done. 21:20:13 INFO - Return code: 0 21:20:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 21:20:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:20:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:20:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:20:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:20:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:20:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:20:13 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7d1b3c9c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24636c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25157c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2559d70>, '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 0x255ab20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255afb0>, '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': '447a3abc0420b6a47dd38cba000001bf-1447996238.572703-268325781', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:20:13 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 21:20:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:20:13 INFO - Using env: {'DISPLAY': ':0', 21:20:13 INFO - 'HOME': '/home/cltbld', 21:20:13 INFO - 'LANG': 'en_US.UTF-8', 21:20:13 INFO - 'LANGUAGE': 'en_US:en', 21:20:13 INFO - 'LOGNAME': 'cltbld', 21:20:13 INFO - 'MAIL': '/var/mail/cltbld', 21:20:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:20:13 INFO - 'MOZ_NO_REMOTE': '1', 21:20:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:20:13 INFO - 'NO_EM_RESTART': '1', 21:20:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:20:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:20:13 INFO - 'PWD': '/builds/slave/test-pgo', 21:20:13 INFO - 'SHELL': '/bin/bash', 21:20:13 INFO - 'SHLVL': '1', 21:20:13 INFO - 'TERM': 'linux', 21:20:13 INFO - 'TMOUT': '86400', 21:20:13 INFO - 'USER': 'cltbld', 21:20:13 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1447996238.572703-268325781', 21:20:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:20:13 INFO - '_': '/tools/buildbot/bin/python'} 21:20:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:20:13 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 21:20:13 INFO - Cleaning up... 21:20:13 INFO - Return code: 0 21:20:13 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 21:20:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:20:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:20:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:20:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:20:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:20:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:20:13 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f7d1b3c9c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24636c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25157c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2559d70>, '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 0x255ab20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255afb0>, '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': '447a3abc0420b6a47dd38cba000001bf-1447996238.572703-268325781', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:20:13 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 21:20:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 21:20:13 INFO - Using env: {'DISPLAY': ':0', 21:20:13 INFO - 'HOME': '/home/cltbld', 21:20:13 INFO - 'LANG': 'en_US.UTF-8', 21:20:13 INFO - 'LANGUAGE': 'en_US:en', 21:20:13 INFO - 'LOGNAME': 'cltbld', 21:20:13 INFO - 'MAIL': '/var/mail/cltbld', 21:20:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:20:13 INFO - 'MOZ_NO_REMOTE': '1', 21:20:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:20:13 INFO - 'NO_EM_RESTART': '1', 21:20:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:20:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:20:13 INFO - 'PWD': '/builds/slave/test-pgo', 21:20:13 INFO - 'SHELL': '/bin/bash', 21:20:13 INFO - 'SHLVL': '1', 21:20:13 INFO - 'TERM': 'linux', 21:20:13 INFO - 'TMOUT': '86400', 21:20:13 INFO - 'USER': 'cltbld', 21:20:13 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1447996238.572703-268325781', 21:20:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:20:13 INFO - '_': '/tools/buildbot/bin/python'} 21:20:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:20:13 INFO - Downloading/unpacking psutil>=0.7.1 21:20:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:20:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:20:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:20:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:20:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:20:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:20:15 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 21:20:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 21:20:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 21:20:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:20:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:20:15 INFO - Installing collected packages: psutil 21:20:15 INFO - Running setup.py install for psutil 21:20:15 INFO - building 'psutil._psutil_linux' extension 21:20:15 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 21:20:15 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 21:20:15 INFO - building 'psutil._psutil_posix' extension 21:20:15 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 21:20:15 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 21:20:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:20:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:20:16 INFO - Successfully installed psutil 21:20:16 INFO - Cleaning up... 21:20:16 INFO - Return code: 0 21:20:16 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 21:20:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:20:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:20:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:20:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:20:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:20:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:20:16 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f7d1b3c9c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24636c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25157c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2559d70>, '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 0x255ab20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255afb0>, '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': '447a3abc0420b6a47dd38cba000001bf-1447996238.572703-268325781', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:20:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 21:20:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 21:20:16 INFO - Using env: {'DISPLAY': ':0', 21:20:16 INFO - 'HOME': '/home/cltbld', 21:20:16 INFO - 'LANG': 'en_US.UTF-8', 21:20:16 INFO - 'LANGUAGE': 'en_US:en', 21:20:16 INFO - 'LOGNAME': 'cltbld', 21:20:16 INFO - 'MAIL': '/var/mail/cltbld', 21:20:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:20:16 INFO - 'MOZ_NO_REMOTE': '1', 21:20:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:20:16 INFO - 'NO_EM_RESTART': '1', 21:20:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:20:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:20:16 INFO - 'PWD': '/builds/slave/test-pgo', 21:20:16 INFO - 'SHELL': '/bin/bash', 21:20:16 INFO - 'SHLVL': '1', 21:20:16 INFO - 'TERM': 'linux', 21:20:16 INFO - 'TMOUT': '86400', 21:20:16 INFO - 'USER': 'cltbld', 21:20:16 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1447996238.572703-268325781', 21:20:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:20:16 INFO - '_': '/tools/buildbot/bin/python'} 21:20:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:20:16 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 21:20:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:20:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:20:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:20:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:20:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:20:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:20:18 INFO - Downloading mozsystemmonitor-0.0.tar.gz 21:20:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 21:20:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:20:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 21:20:19 INFO - Installing collected packages: mozsystemmonitor 21:20:19 INFO - Running setup.py install for mozsystemmonitor 21:20:19 INFO - Successfully installed mozsystemmonitor 21:20:19 INFO - Cleaning up... 21:20:19 INFO - Return code: 0 21:20:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 21:20:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:20:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:20:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:20:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:20:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:20:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:20:19 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 0x7f7d1b3c9c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24636c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25157c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2559d70>, '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 0x255ab20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255afb0>, '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': '447a3abc0420b6a47dd38cba000001bf-1447996238.572703-268325781', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:20:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 21:20:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:20:19 INFO - Using env: {'DISPLAY': ':0', 21:20:19 INFO - 'HOME': '/home/cltbld', 21:20:19 INFO - 'LANG': 'en_US.UTF-8', 21:20:19 INFO - 'LANGUAGE': 'en_US:en', 21:20:19 INFO - 'LOGNAME': 'cltbld', 21:20:19 INFO - 'MAIL': '/var/mail/cltbld', 21:20:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:20:19 INFO - 'MOZ_NO_REMOTE': '1', 21:20:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:20:19 INFO - 'NO_EM_RESTART': '1', 21:20:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:20:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:20:19 INFO - 'PWD': '/builds/slave/test-pgo', 21:20:19 INFO - 'SHELL': '/bin/bash', 21:20:19 INFO - 'SHLVL': '1', 21:20:19 INFO - 'TERM': 'linux', 21:20:19 INFO - 'TMOUT': '86400', 21:20:19 INFO - 'USER': 'cltbld', 21:20:19 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1447996238.572703-268325781', 21:20:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:20:19 INFO - '_': '/tools/buildbot/bin/python'} 21:20:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:20:19 INFO - Downloading/unpacking blobuploader==1.2.4 21:20:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:20:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:20:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:20:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:20:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:20:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:20:21 INFO - Downloading blobuploader-1.2.4.tar.gz 21:20:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 21:20:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:20:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:20:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:20:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:20:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:20:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:20:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:20:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:20:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 21:20:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 21:20:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:20:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:20:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:20:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:20:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:20:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:20:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:20:21 INFO - Downloading docopt-0.6.1.tar.gz 21:20:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 21:20:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 21:20:21 INFO - Installing collected packages: blobuploader, requests, docopt 21:20:21 INFO - Running setup.py install for blobuploader 21:20:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:20:21 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 21:20:21 INFO - Running setup.py install for requests 21:20:22 INFO - Running setup.py install for docopt 21:20:22 INFO - Successfully installed blobuploader requests docopt 21:20:22 INFO - Cleaning up... 21:20:22 INFO - Return code: 0 21:20:22 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:20:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:20:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:20:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:20:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:20:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:20:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:20:22 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 0x7f7d1b3c9c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24636c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25157c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2559d70>, '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 0x255ab20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255afb0>, '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': '447a3abc0420b6a47dd38cba000001bf-1447996238.572703-268325781', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:20:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 21:20:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:20:22 INFO - Using env: {'DISPLAY': ':0', 21:20:22 INFO - 'HOME': '/home/cltbld', 21:20:22 INFO - 'LANG': 'en_US.UTF-8', 21:20:22 INFO - 'LANGUAGE': 'en_US:en', 21:20:22 INFO - 'LOGNAME': 'cltbld', 21:20:22 INFO - 'MAIL': '/var/mail/cltbld', 21:20:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:20:22 INFO - 'MOZ_NO_REMOTE': '1', 21:20:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:20:22 INFO - 'NO_EM_RESTART': '1', 21:20:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:20:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:20:22 INFO - 'PWD': '/builds/slave/test-pgo', 21:20:22 INFO - 'SHELL': '/bin/bash', 21:20:22 INFO - 'SHLVL': '1', 21:20:22 INFO - 'TERM': 'linux', 21:20:22 INFO - 'TMOUT': '86400', 21:20:22 INFO - 'USER': 'cltbld', 21:20:22 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1447996238.572703-268325781', 21:20:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:20:22 INFO - '_': '/tools/buildbot/bin/python'} 21:20:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:20:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:20:22 INFO - Running setup.py (path:/tmp/pip-S37DIz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:20:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:20:22 INFO - Running setup.py (path:/tmp/pip-Ll9uo5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:20:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:20:22 INFO - Running setup.py (path:/tmp/pip-5yJwfr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:20:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:20:22 INFO - Running setup.py (path:/tmp/pip-OdMlrn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:20:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 21:20:22 INFO - Running setup.py (path:/tmp/pip-j8qfud-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 21:20:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:20:22 INFO - Running setup.py (path:/tmp/pip-WcfAht-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:20:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:20:23 INFO - Running setup.py (path:/tmp/pip-n_b_AL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:20:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:20:23 INFO - Running setup.py (path:/tmp/pip-Cke9dF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:20:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 21:20:23 INFO - Running setup.py (path:/tmp/pip-31LDzX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 21:20:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 21:20:23 INFO - Running setup.py (path:/tmp/pip-9uxTHe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 21:20:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:20:23 INFO - Running setup.py (path:/tmp/pip-NE1yzy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:20:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:20:23 INFO - Running setup.py (path:/tmp/pip-iv3HTM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:20:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:20:23 INFO - Running setup.py (path:/tmp/pip-WVeVbn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:20:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:20:23 INFO - Running setup.py (path:/tmp/pip-ckoaqo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:20:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:20:23 INFO - Running setup.py (path:/tmp/pip-CPAWfi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:20:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 21:20:23 INFO - Running setup.py (path:/tmp/pip-2dOJF5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 21:20:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 21:20:23 INFO - Running setup.py (path:/tmp/pip-6q2Lnq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 21:20:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:20:23 INFO - Running setup.py install for manifestparser 21:20:23 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 21:20:23 INFO - Running setup.py install for mozcrash 21:20:23 INFO - Running setup.py install for mozdebug 21:20:24 INFO - Running setup.py install for mozdevice 21:20:24 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 21:20:24 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 21:20:24 INFO - Running setup.py install for mozfile 21:20:24 INFO - Running setup.py install for mozhttpd 21:20:24 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 21:20:24 INFO - Running setup.py install for mozinfo 21:20:24 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 21:20:24 INFO - Running setup.py install for mozInstall 21:20:24 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 21:20:24 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 21:20:24 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 21:20:24 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 21:20:24 INFO - Running setup.py install for mozleak 21:20:24 INFO - Running setup.py install for mozlog 21:20:24 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 21:20:24 INFO - Running setup.py install for moznetwork 21:20:24 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 21:20:24 INFO - Running setup.py install for mozprocess 21:20:25 INFO - Running setup.py install for mozprofile 21:20:25 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 21:20:25 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 21:20:25 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 21:20:25 INFO - Running setup.py install for mozrunner 21:20:25 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 21:20:25 INFO - Running setup.py install for mozscreenshot 21:20:25 INFO - Running setup.py install for moztest 21:20:25 INFO - Running setup.py install for mozversion 21:20:25 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 21:20:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:20:25 INFO - Cleaning up... 21:20:25 INFO - Return code: 0 21:20:25 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:20:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:20:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:20:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:20:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:20:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:20:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:20:25 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 0x7f7d1b3c9c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24636c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25157c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2559d70>, '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 0x255ab20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255afb0>, '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': '447a3abc0420b6a47dd38cba000001bf-1447996238.572703-268325781', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:20:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 21:20:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:20:25 INFO - Using env: {'DISPLAY': ':0', 21:20:25 INFO - 'HOME': '/home/cltbld', 21:20:25 INFO - 'LANG': 'en_US.UTF-8', 21:20:25 INFO - 'LANGUAGE': 'en_US:en', 21:20:25 INFO - 'LOGNAME': 'cltbld', 21:20:25 INFO - 'MAIL': '/var/mail/cltbld', 21:20:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:20:25 INFO - 'MOZ_NO_REMOTE': '1', 21:20:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:20:25 INFO - 'NO_EM_RESTART': '1', 21:20:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:20:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:20:25 INFO - 'PWD': '/builds/slave/test-pgo', 21:20:25 INFO - 'SHELL': '/bin/bash', 21:20:25 INFO - 'SHLVL': '1', 21:20:25 INFO - 'TERM': 'linux', 21:20:25 INFO - 'TMOUT': '86400', 21:20:25 INFO - 'USER': 'cltbld', 21:20:25 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1447996238.572703-268325781', 21:20:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:20:25 INFO - '_': '/tools/buildbot/bin/python'} 21:20:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:20:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:20:25 INFO - Running setup.py (path:/tmp/pip-T0znAc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:20:25 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 21:20:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:20:25 INFO - Running setup.py (path:/tmp/pip-KThXvR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:20:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 21:20:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:20:25 INFO - Running setup.py (path:/tmp/pip-of17cF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:20:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 21:20:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:20:25 INFO - Running setup.py (path:/tmp/pip-Ok2Llo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:20:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 21:20:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 21:20:26 INFO - Running setup.py (path:/tmp/pip-HxNgSt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 21:20:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 21:20:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:20:26 INFO - Running setup.py (path:/tmp/pip-WhxYeX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:20:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 21:20:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:20:26 INFO - Running setup.py (path:/tmp/pip-ppWJTu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:20:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 21:20:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:20:26 INFO - Running setup.py (path:/tmp/pip-snNON4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:20:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 21:20:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 21:20:26 INFO - Running setup.py (path:/tmp/pip-xt1cbZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 21:20:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 21:20:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 21:20:26 INFO - Running setup.py (path:/tmp/pip-EjNbws-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 21:20:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 21:20:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:20:26 INFO - Running setup.py (path:/tmp/pip-SI53qv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:20:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 21:20:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:20:26 INFO - Running setup.py (path:/tmp/pip-FSYaf1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:20:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 21:20:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:20:26 INFO - Running setup.py (path:/tmp/pip-iRR2vP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:20:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 21:20:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:20:26 INFO - Running setup.py (path:/tmp/pip-SevN1e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:20:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 21:20:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:20:26 INFO - Running setup.py (path:/tmp/pip-dgJpzr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:20:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 21:20:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 21:20:26 INFO - Running setup.py (path:/tmp/pip-XqByhh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 21:20:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 21:20:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 21:20:26 INFO - Running setup.py (path:/tmp/pip-ULQrBE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 21:20:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 21:20:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 21:20:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 21:20:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 21:20:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 21:20:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 21:20:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 21:20:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:20:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:20:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:20:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:20:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:20:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:20:28 INFO - Downloading blessings-1.5.1.tar.gz 21:20:28 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 21:20:28 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 21:20:28 INFO - Installing collected packages: blessings 21:20:28 INFO - Running setup.py install for blessings 21:20:28 INFO - Successfully installed blessings 21:20:28 INFO - Cleaning up... 21:20:28 INFO - Return code: 0 21:20:28 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 21:20:28 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 21:20:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 21:20:29 INFO - Reading from file tmpfile_stdout 21:20:29 INFO - Current package versions: 21:20:29 INFO - argparse == 1.2.1 21:20:29 INFO - blessings == 1.5.1 21:20:29 INFO - blobuploader == 1.2.4 21:20:29 INFO - docopt == 0.6.1 21:20:29 INFO - manifestparser == 1.1 21:20:29 INFO - mozInstall == 1.12 21:20:29 INFO - mozcrash == 0.16 21:20:29 INFO - mozdebug == 0.1 21:20:29 INFO - mozdevice == 0.47 21:20:29 INFO - mozfile == 1.2 21:20:29 INFO - mozhttpd == 0.7 21:20:29 INFO - mozinfo == 0.9 21:20:29 INFO - mozleak == 0.1 21:20:29 INFO - mozlog == 3.0 21:20:29 INFO - moznetwork == 0.27 21:20:29 INFO - mozprocess == 0.22 21:20:29 INFO - mozprofile == 0.27 21:20:29 INFO - mozrunner == 6.11 21:20:29 INFO - mozscreenshot == 0.1 21:20:29 INFO - mozsystemmonitor == 0.0 21:20:29 INFO - moztest == 0.7 21:20:29 INFO - mozversion == 1.4 21:20:29 INFO - psutil == 3.1.1 21:20:29 INFO - requests == 1.2.3 21:20:29 INFO - wsgiref == 0.1.2 21:20:29 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:20:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:20:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:20:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:20:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:20:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:20:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:20:29 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 0x7f7d1b3c9c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24636c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25157c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2559d70>, '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 0x255ab20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255afb0>, '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': '447a3abc0420b6a47dd38cba000001bf-1447996238.572703-268325781', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:20:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 21:20:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:20:29 INFO - Using env: {'DISPLAY': ':0', 21:20:29 INFO - 'HOME': '/home/cltbld', 21:20:29 INFO - 'LANG': 'en_US.UTF-8', 21:20:29 INFO - 'LANGUAGE': 'en_US:en', 21:20:29 INFO - 'LOGNAME': 'cltbld', 21:20:29 INFO - 'MAIL': '/var/mail/cltbld', 21:20:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:20:29 INFO - 'MOZ_NO_REMOTE': '1', 21:20:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:20:29 INFO - 'NO_EM_RESTART': '1', 21:20:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:20:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:20:29 INFO - 'PWD': '/builds/slave/test-pgo', 21:20:29 INFO - 'SHELL': '/bin/bash', 21:20:29 INFO - 'SHLVL': '1', 21:20:29 INFO - 'TERM': 'linux', 21:20:29 INFO - 'TMOUT': '86400', 21:20:29 INFO - 'USER': 'cltbld', 21:20:29 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1447996238.572703-268325781', 21:20:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:20:29 INFO - '_': '/tools/buildbot/bin/python'} 21:20:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:20:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 21:20:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 21:20:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 21:20:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 21:20:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 21:20:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 21:20:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 21:20:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 21:20:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 21:20:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 21:20:29 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 21:20:29 INFO - Cleaning up... 21:20:29 INFO - Return code: 0 21:20:29 INFO - Running post-action listener: _resource_record_post_action 21:20:29 INFO - Running post-action listener: _start_resource_monitoring 21:20:29 INFO - Starting resource monitoring. 21:20:29 INFO - ##### 21:20:29 INFO - ##### Running install step. 21:20:29 INFO - ##### 21:20:29 INFO - Running pre-action listener: _resource_record_pre_action 21:20:29 INFO - Running main action method: install 21:20:29 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 21:20:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 21:20:29 INFO - Reading from file tmpfile_stdout 21:20:29 INFO - Detecting whether we're running mozinstall >=1.0... 21:20:29 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 21:20:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 21:20:29 INFO - Reading from file tmpfile_stdout 21:20:29 INFO - Output received: 21:20:29 INFO - Usage: mozinstall [options] installer 21:20:29 INFO - Options: 21:20:29 INFO - -h, --help show this help message and exit 21:20:29 INFO - -d DEST, --destination=DEST 21:20:29 INFO - Directory to install application into. [default: 21:20:29 INFO - "/builds/slave/test-pgo"] 21:20:29 INFO - --app=APP Application being installed. [default: firefox] 21:20:29 INFO - mkdir: /builds/slave/test-pgo/build/application 21:20:29 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 21:20:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 21:20:44 INFO - Reading from file tmpfile_stdout 21:20:44 INFO - Output received: 21:20:44 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 21:20:44 INFO - Running post-action listener: _resource_record_post_action 21:20:44 INFO - ##### 21:20:44 INFO - ##### Running run-tests step. 21:20:44 INFO - ##### 21:20:44 INFO - Running pre-action listener: _resource_record_pre_action 21:20:44 INFO - Running main action method: run_tests 21:20:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 21:20:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 21:20:44 INFO - Python 2.7.3 21:20:44 INFO - Return code: 0 21:20:44 INFO - grabbing minidump binary from tooltool 21:20:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:20:44 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 0x2559d70>, '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 0x255ab20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255afb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 21:20:44 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 21:20:44 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 21:20:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:20:44 INFO - Return code: 0 21:20:44 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 21:20:44 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 21:20:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 21:20:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 21:20:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 21:20:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/-aDrMBVKT8Ss3r1ume4yzw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 21:20:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/-aDrMBVKT8Ss3r1ume4yzw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-027 --webServer localhost 21:20:44 INFO - Using env: {'DISPLAY': ':0', 21:20:44 INFO - 'HOME': '/home/cltbld', 21:20:44 INFO - 'LANG': 'en_US.UTF-8', 21:20:44 INFO - 'LANGUAGE': 'en_US:en', 21:20:44 INFO - 'LOGNAME': 'cltbld', 21:20:44 INFO - 'MAIL': '/var/mail/cltbld', 21:20:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 21:20:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 21:20:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:20:44 INFO - 'MOZ_NO_REMOTE': '1', 21:20:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 21:20:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:20:44 INFO - 'NO_EM_RESTART': '1', 21:20:44 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:20:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:20:44 INFO - 'PWD': '/builds/slave/test-pgo', 21:20:44 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 21:20:44 INFO - 'SHELL': '/bin/bash', 21:20:44 INFO - 'SHLVL': '1', 21:20:44 INFO - 'TERM': 'linux', 21:20:44 INFO - 'TMOUT': '86400', 21:20:44 INFO - 'USER': 'cltbld', 21:20:44 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1447996238.572703-268325781', 21:20:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:20:44 INFO - '_': '/tools/buildbot/bin/python'} 21:20:44 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/-aDrMBVKT8Ss3r1ume4yzw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--webServer', 'localhost'] with output_timeout 3600 21:20:45 INFO - mozversion INFO | application_buildid: 20151119193324 21:20:45 INFO - mozversion INFO | application_changeset: 1946937e23afd1e6783d2f83737b074fa680c9a8 21:20:45 INFO - mozversion INFO | application_display_name: Nightly 21:20:45 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:20:45 INFO - mozversion INFO | application_name: Firefox 21:20:45 INFO - mozversion INFO | application_remotingname: firefox 21:20:45 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 21:20:45 INFO - mozversion INFO | application_vendor: Mozilla 21:20:45 INFO - mozversion INFO | application_version: 45.0a1 21:20:45 INFO - mozversion INFO | platform_buildid: 20151119193324 21:20:45 INFO - mozversion INFO | platform_changeset: 1946937e23afd1e6783d2f83737b074fa680c9a8 21:20:45 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 21:20:45 INFO - mozversion INFO | platform_version: 45.0a1 21:20:45 INFO - 2015-11-19 21:20:45,080 DEBUG : using testdate: 1447996845 21:20:45 INFO - 2015-11-19 21:20:45,080 DEBUG : actual date: 1447996845 21:20:45 INFO - 2015-11-19 21:20:45,172 INFO : starting webserver on 'localhost:59757' 21:20:45 INFO - 2015-11-19 21:20:45,173 INFO : Starting test suite talos-linux64-ix-027 21:20:45 INFO - 2015-11-19 21:20:45,173 INFO : Starting test dromaeo_css 21:20:45 INFO - 2015-11-19 21:20:45,173 DEBUG : operating with platform_type : linux_ 21:20:45 INFO - 2015-11-19 21:20:45,174 INFO : Initialising browser for dromaeo_css test... 21:20:45 INFO - 2015-11-19 21:20:45,189 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpTIsZtV/profile http://localhost:59757/getInfo.html 21:20:49 INFO - 2015-11-19 21:20:49,305 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 21:20:49 INFO - 2015-11-19 21:20:49,305 DEBUG : BROWSER_OUTPUT: colorDepth:24 21:20:49 INFO - 2015-11-19 21:20:49,305 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 21:20:49 INFO - 2015-11-19 21:20:49,305 DEBUG : BROWSER_OUTPUT: __metrics 21:20:49 INFO - 2015-11-19 21:20:49,414 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:20:50 INFO - 2015-11-19 21:20:50,759 INFO : Browser initialized. 21:20:50 INFO - 2015-11-19 21:20:50,759 INFO : Running cycle 1/1 for dromaeo_css test... 21:20:50 INFO - 2015-11-19 21:20:50,759 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpTIsZtV/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 21:21:02 INFO - 2015-11-19 21:21:02,485 DEBUG : BROWSER_OUTPUT: RSS: Main: 142323712 21:21:02 INFO - 2015-11-19 21:21:02,485 DEBUG : BROWSER_OUTPUT: 21:21:53 INFO - 2015-11-19 21:21:53,208 DEBUG : BROWSER_OUTPUT: 1447996913206 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] 21:24:03 INFO - 2015-11-19 21:24:03,224 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59757/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59757/tests/dromaeo/cssquery-ext.html) 21:24:04 INFO - 2015-11-19 21:24:04,334 DEBUG : BROWSER_OUTPUT: RSS: Main: 250519552 21:24:04 INFO - 2015-11-19 21:24:04,334 DEBUG : BROWSER_OUTPUT: 21:27:06 INFO - 2015-11-19 21:27:06,710 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59757/tests/dromaeo/cssquery-ext.html (next: http://localhost:59757/tests/dromaeo/cssquery-jquery.html) 21:27:07 INFO - 2015-11-19 21:27:07,276 DEBUG : BROWSER_OUTPUT: RSS: Main: 221687808 21:27:07 INFO - 2015-11-19 21:27:07,276 DEBUG : BROWSER_OUTPUT: 21:30:09 INFO - 2015-11-19 21:30:09,201 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59757/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59757/tests/dromaeo/cssquery-mootools.html) 21:30:09 INFO - 2015-11-19 21:30:09,767 DEBUG : BROWSER_OUTPUT: RSS: Main: 204029952 21:30:09 INFO - 2015-11-19 21:30:09,768 DEBUG : BROWSER_OUTPUT: 21:33:11 INFO - 2015-11-19 21:33:11,610 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59757/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59757/tests/dromaeo/cssquery-prototype.html) 21:33:12 INFO - 2015-11-19 21:33:12,176 DEBUG : BROWSER_OUTPUT: RSS: Main: 193490944 21:33:12 INFO - 2015-11-19 21:33:12,176 DEBUG : BROWSER_OUTPUT: 21:36:14 INFO - 2015-11-19 21:36:14,685 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59757/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59757/tests/dromaeo/cssquery-yui.html) 21:36:15 INFO - 2015-11-19 21:36:15,246 DEBUG : BROWSER_OUTPUT: RSS: Main: 201166848 21:36:15 INFO - 2015-11-19 21:36:15,246 DEBUG : BROWSER_OUTPUT: 21:39:17 INFO - 2015-11-19 21:39:17,819 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59757/tests/dromaeo/cssquery-yui.html (next: http://localhost:59757/tests/dromaeo/cssquery-dojo.html) 21:39:18 INFO - 2015-11-19 21:39:18,063 DEBUG : BROWSER_OUTPUT: RSS: Main: 285728768 21:39:18 INFO - 2015-11-19 21:39:18,063 DEBUG : BROWSER_OUTPUT: 21:39:18 INFO - 2015-11-19 21:39:18,064 DEBUG : BROWSER_OUTPUT: __start_tp_report 21:39:18 INFO - 2015-11-19 21:39:18,065 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 21:39:18 INFO - 2015-11-19 21:39:18,065 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 21:39:18 INFO - 2015-11-19 21:39:18,065 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 21:39:18 INFO - 2015-11-19 21:39:18,065 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3172.143521249263;3288.227266592352;3307.140143562673;3316.005198440467;3358.546596209512;5293.9735301323435;5468.453154684539;5507.862303442416;5516.448355164486;5544.889102217953;5435.83692489226;5448.618596698233;5492.368377636573;5506.394296627368;5561.193626924093;4974.104661160981;4992.775325110379;5022.296878437021;5029.1450453423;5062.594992400599;4947.77735001924;5128.102582048145;5145.76844042019;5172.534471897528;5211.140161873286;4931.630127740434;4983.825566105187;5026.5727413169925;5034.572061374751;5049.596032317442;4992.276119962621;5057.393112826484;5075.492450754932;5095;5110.310108135429;4947.480514545993;5043.445221025684;5055.064813009568;5065.544101030925;5086.160783470723;5335.839924802262;5377.0321342158395;5405.783768649249;5420;5433.049216387117;5912.793052243151;5923.674197919113;5930.614510056876;5936.940630593682;5938.0499120141;5693.089105743103;5792.015357389254;5910.763569457216;5926.348101708809;5936.821895343147;5406.351237851483;5514.283143191359;5516.420775818561;5518.144687573433;5595.21666966625;6004.219451471368;6005.489533389711;6018.127371531104;6058.333583305921;6114.602550834182;5752.511036561856;5808.332041815161;5812.128180772918;5812.912806307909;5857.970710146422;5810.709464526757;5811.418858114239;5918.319393269829;5923.4076592340425;5932.762689492372;5863;5868.383819698955;5889.998700220973;5926;5956.6723830188885;5821.388754180834;5839.386864379264;5856;5857.88284234313;5878.853028674232;4399.186150562156;4449.443819522559;4527.0493196429115;4530.252508336153;4539.409876716072;4045.5347635021762;4073.4311818918895;4087.509498860156;4092.836286548564;4095.0171958730284;5657.6039677223025;5686.3691314233465;5687.943120568824;5696.1455781633085;5707.514861236758;5719.971400142973;5833.38749431312;5836.387179346108;5837.3870743571315;6083.665398403042;5583.441655834384;5592.356878958891;5632.845266720313;5668.971655141698;5671.943280567141;5194.3247377840635;5222.686638801684;5235.188545775335;5237.711925844115;5239.44985776488;5890.234269545017;5954.702264886651;6174.073888916699;6182.1345011698395;6208.81373558794;5827.446392592697;5892.970535147297;5904.3210030847;5954.225950626391;5979.521638269015;6056.031035034373;6056.06131049688;6076.058210977306;6076.422739839708;6195.566310358232;5693.146028095819;5780.104083867007;5789.594728368974;5804.883902322014;5829.8251052468495;5693.231413759089;5757.222774925332;5760.452756988079;5766.452187042224;5813.709314534341;5869.853253668693;5869.94130058711;5875.50058245054;5882.970585147047;5897.085951677497;5782.942170578241;5835.037218858841;5842.152887831326;5852.239208902815;5858.209141765978;5430.5384042356845;5503.449655034465;5547.5007249347755;5561.054620714407;5663.716814159358;5815.33123690764;5857.326407463196;5903.793367232126;5949.8215053548465;5963.552733545088;5721.599488035964;5750.971245143747;5786.07422812348;5788.363280039276;5790.478856902899 21:39:18 INFO - 2015-11-19 21:39:18,068 DEBUG : BROWSER_OUTPUT: |1;ext.html;578.3262499188446;591.952643788497;598.736555915397;599.7720866070892;611.0986295214557;31283.843580782093;32061.83969080157;32070.839645801767;32086.197845053855;32143.678563214362;40326.59673403265;41217.175656486856;41238;41289.17421651573;41322.7933860331;8881.600327985256;9053.50205738684;9059.547022648874;9059.682911098113;9060.546972651375;7815.218478152167;8001.279884810366;8005.559694216816;8844.646214151426;8958.596863141142;10762.892371076307;10990.615328463506;10991.395473248967;11013.83479247812;11030.834537481944;10510.579576816956;10545.420001899893;10582.470876456224;10629.5216715248;10640.201984851166;7813;7995.360371170351;10378.221633377527;10524.421156836372;10608.734781630445;39996;40412.59587404118;40434.797826010974;40436.191276174315;40467.79766101151;3355.3457075870215;3588.8731077008565;3742.5321834770652;3897.279003384383;4082.9795851020854;30485.542716859265;30874.691253087407;31272.843635781905;31323;31398.686013139806;3938.2714197873483;3969.543502497192;3978;4030.3016773079808;4037.656799172074;299586;303235;304659;421409;426038;55846.441535584934;56465.30604081884;56490.435095648514;56556.71721641366;56557.434425656036;61642.69178654078;61846;62093.068603970976;62317.688411558556;62355.68822155951;14696.632584185481;14893.18087505176;14909.403623855142;14983.775243371358;15092.245387730569;12082;12233.816492752616;12235.69410764738;12245.08161887862;12251;20176.798232017787;20381.49046273855;20414.591708166052;20452.488687782923;20485.59028819415;7495.550266983998;7677.616119194018;7692.538447693157;7701.1143718473095;7763.136847156755;916.6562539047857;957.7844984878486;996.3324572536418;1002.7042022603349;1024.6618615856748;29878.25304367408;29913.700862991525;29996.250093747833;30077.548836767466;30245;1014.4978235773192;1034.0900007992918;1040.9115225205942;1043;1077.9245452818227;15114.622134446507;15329.540113796382;15604.375824966874;15612.687746245012;15618.297176626851;320451;323753;325198;327554;327952;54001.72999134979;54263.18605220846;54319;54419;54424;1332.4670131947298;1344.6638340414897;1363.4886917405972;1364.9658758530918;1368.9178649281075;28701.569476458288;29303.560446592892;30125.698743013167;30334;31233.375332492767;47453;47881.52118478771;47889.760551198415;47893.28160077532;47927;273821;278919;294816;299081;299840;30779;30813.845930770203;30991.380172396875;31056.378872422876;31144;44118.33822492729;45226.32160517661;45291;45889.311660324456;46244.76877615591;37476.625233748404;37830.62169378271;38453.230935380576;38934.41598376083;39210.60789392069;36175.27649447049;36916.446253306756;37616.24767504689;38708.6129138705;38859.80570097244;33316.33367332688;33419.66580334165;36483;37144.628553714116;37233;28998.855005724836;32214.516782247818;32329.51505727463;32409.51385729263;32591.674083258862;24678.74006335579;24801.511909285502;24928.62607060932;25044.12345567969;25376.365590860376 21:39:18 INFO - 2015-11-19 21:39:18,070 DEBUG : BROWSER_OUTPUT: |2;jquery.html;355.34793653645556;357.297909607621;357.6030606027311;357.64235764235747;358.91386067343836;13741.450341986309;14146;16160.515184544467;16384.67230655386;17073.231704573293;14616.707665846676;15943.282552285145;15957.281922313494;15984.920075399636;16944.491665250032;5352.785888564453;5509.090999985017;5510.201020851974;5513.338399392059;5515.448455154493;3995.8201880915285;4063.2686116499017;5442.156465747816;5480.150576660604;5893.263342082239;5951.613145145551;5978.342382337939;6004;6007.609505382136;6008.369121242272;5028.823991160292;5160.251763494272;5162.793488260465;5163.044836705203;5958.9702051489685;4919.385076865392;4960.082384758831;4960.206366981266;4981.277714731344;5067.543921047123;12221.205621634654;12316.076294277966;12403.813942790865;15621.687566248725;19816.30642927505;2053.537953960362;2066.442060643633;2072.3990042887544;2098.5068508900395;2202.031106313217;8973.865392019125;9766.365186262941;12193.902548770653;12334.629961101182;12619.684507887285;1759.7448369986407;1783.2153852304943;1786.1337251433044;1821.307902996866;1847.575057736728;59435;61418.38581614216;62432.37567624311;62701.37298627001;62746;9714.805703885882;9957.601695932082;9965.850512242323;9980.255429756875;10039.498025098716;13204.801927971088;13232.470701172038;13275.468981240836;13276.933615331862;13281.601551953458;7114.501984861114;7145.857082858313;7364.889526656997;7469.663865126083;7489.101307842985;6462.095306657072;6481.351864813481;6503.349665033554;6523.282438931714;6546.639934803537;4080.0819815541267;4089.7137200395687;4098.672106231495;4189.937150942738;4245.172191422643;1621.60270733671;1691.7124088904916;1697.244726096875;2743.2593199835933;2843.4170994945985;833.5540485840046;908.7864351877304;921.235374639048;937.7280588629358;1076.6769969009265;16590.17049147538;17051.403200887908;17389.82610173882;17409.303627854744;17522.737158942626;436.8990144834998;437.2435686262783;448.9012417268196;919.4942781470164;1018.872640919885;5461;5817.50551203144;5840.065589505659;5893.764249430061;5935.703214839241;358006;364857;407694;527807;531869;79623;83296;84638;84671;84696;471.69811320754746;485.09529727059487;485.95383438573276;486.0061174897343;486.5912633387971;9993.850092248767;10016.048475394826;10035.54840032215;10071.798564028531;10132;34091.48862767011;34943.475847861795;35355.64644353523;35474;35966.280674386886;46027.07945840997;46321.76839115783;47308.52691473041;47487;47570;9417.764555886157;9445.29160312993;9455.574499147417;9626.181774549243;9634.566444509874;17044.14779261007;17105.914470427568;17159.31362745476;17308.394206202724;17952.640947181244;13799.448022079005;14775.704485910437;14854.628634284229;14869.776953345925;15012.324445400202;14543.85456145425;14637.341319640429;14777.261136942894;14808.481703140338;15294.464693735667;14467.27663616836;14890.925545372203;15092.773608395662;15179.544613661608;15701;9400;9435.716928492157;9581.137697607248;9610.231181505602;9636.614535418505;2803.3412148145576;11338.670824712372;13024.218546887218;14607.634809129857;14892 21:39:18 INFO - 2015-11-19 21:39:18,071 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1309.0967232609505;1638.6804573108243;1698.150924537731;1716.545115544381;1728.3777839977606;6463.418292353687;7445.255474452552;7596.126445458767;7599.430042746802;7600.5439673619485;7401;7514.887276690841;7517.661705223264;7528.58592777397;7528.623568821551;2170.5007848194923;2188.9014994325294;2193.74771901231;2197.703310053146;2197.846150769447;2231.866088034723;2239.7760223977634;2244.5286489837154;2255.1768604459335;2265.2411442166813;2160.7083043789044;2187.912483500666;2190.5728382965326;2192.7697591752876;2193.1775584155944;2169.7830216978255;2175.9555413401654;2176.227439259056;2178.4662757624483;2178.6296329624;2236.9217077402213;2283.4633861042644;2285.0973865323103;2285.371522831218;2286.7713228677167;6557.967210163966;6762;7482.102147742251;7524.209957954446;7539.170691223961;4427.358033085216;4550.703049630839;4553.954460455386;4559.863204103882;4565.223911934979;3054.053243494524;3069.3400918802563;3097.3650401667605;3104.6584875663657;3211.0527394418705;1090.9127269818396;1116.4083035990939;1136.7044568412189;1141.6403832792644;1144.525022115821;10344.5344959477;10613.681589552325;10632.734181645521;10634.787304253949;10637.255392122555;4057.330540460791;4097.180563887175;4136.875893723193;4137.234611596864;4142.647874930604;8617.827643447095;8638.611262493203;8640.870386944202;8644.697435589724;8649.740507784776;4609.907801844011;4624.190766615829;4635.884102897455;4637.1421287062;4638.489766125724;4257.808398622069;4264.1471705659;4269.316909294498;4273.67947403946;4275.315949448073;3429.3484237994703;3437;3440.82795860206;3447.258839349552;3464.411050121435;1038.2109596706557;1051.9263651544472;1054.6045233037612;1057.471264367816;1060.261171678448;1286.6075846866795;1296.403654319005;1310.9344532773323;1340.9664758380923;1341.3427420563853;7239.384652304508;7250.891236631454;7317.780466586011;7319;7348.2284360142485;458.6147635985788;469.48825779900073;481.68208982072366;482.6114977443192;483.59136529632406;5084.923726144111;5408.567314614821;5454.536364409069;5458.5087342139395;5473.698946557977;8271.462354947029;9028.277737781093;9163.31275154366;9278;9278.62885484573;8884.555772211364;9040.367174297737;9049.502277374675;9121.224695900923;9164.95417522908;7089.149302083783;7160.10498687664;7181;7186.928130718626;7206.207317195104;6957.965210173917;6998.090248267693;7011.509194356346;7045.1898031727005;7067.187273463617;7854.096778870275;7876.684932602631;8061.556614386265;8092.83814323722;8097.190280971856;8041.195880411912;8142;8154.673813047411;8259.504429734236;8290.502569845828;7034.155901291878;7122.893156602759;7135.928640713526;7141.64291785419;7146.392556632744;7245.818854528679;7390.1131864174495;7393.519421237603;7423.517471364344;7433.665485053294;6766;6773.932260677528;6812.386885180357;6817.079694241214;6849.589024658537;6829.897551536632;6953.965230174019;6958.617276049866;7027.61348125858;7062.117235345582;6870.7595234166565;6961.686724097326;6978.720851165896;6982.231954484901;6995.79012629622;6425.742970281136;6442.677866106582;6448.355164483514;6466.773662921775;6470.708818103102;6126.479249263684;6241.157443745036;6242.750289988349;6257.2804127525915;6440.742370305135 21:39:18 INFO - 2015-11-19 21:39:18,075 DEBUG : BROWSER_OUTPUT: |4;prototype.html;318.361684821932;323.88340197528885;325.4597368368509;328.83722557334124;336.07076433660933;5975.312839023519;5979.1629171915965;5991.730372133254;6037.577369584131;6073.1497590337385;5705.343885453174;5796.62321949073;5847.327557330908;5924.229850119489;5956.5234781217505;4558.225101732697;4580.083983203373;4582;4582.633389328862;4595.126925884079;4407.603315701586;4583.793729282191;4593.356930029799;4595.678302518825;4596.310553416981;4429.379886815848;4491.483479399862;4520.11857687751;4532.864014079583;4538.6369090472845;4444.644428445717;4494.662900282492;4507.932381014288;4511.142882852264;4512.278035514302;3987.4218238355566;4008.178323443716;4010.8796736097966;4013.618706222904;4014.3376342903384;5478.260434841325;5653.575981801381;5662.150677398423;5664.575156863251;5668.546516278688;5287.841364759025;5301.257823904618;5318.547923426513;5318.680879147263;5322.654027488201;6342.39747224013;6342.556021078526;6343.8731225375695;6347.777827776005;6350.745970161188;4460.576245256695;4463.419755431805;4465.352523884018;4465.9106817863785;4477.48508921475;6417.326180751001;6586.04502347157;6586.967065164691;6589.901151482732;6597.571157874723;4446.777661116931;4481.103779244099;4481.327800829901;4483.574060464251;4486.708363956398;4537.274036154199;4537.636989040869;4538.88652783683;4542.295944128599;4543.159515489645;5263.6315457918345;5264.499872512105;5264.684118952875;5272.05103081449;5276.182191760283;6253.468455181361;6386.712597933104;6388.8083357499345;6400.295967443578;6408.166938297992;1579.778830963666;1592.944246951351;1597.2013993003497;1598.7601859720903;1599.072537927999;1042.6871938418597;1049.994750026245;1059.5391004912888;1067.8558394616782;1068.71144790906;6204.751809927642;6207.96896015517;6212.9068063979075;6214.937850621436;6216.906746398808;6589.835254118685;6592.24189218246;6593.703283352261;6605.07528945948;6619.5035372347265;6030.849228769228;6131.325554189036;6183.3816618337805;6276.246850377984;6295.811125666238;3568.3398571264397;3578.5526809148855;3586.228960773446;3594.658507441789;3595.7303202259936;6843.863122737517;6857.725690972405;6861.1080559526945;6862;6868.793936181923;6602;6789;6800.727970881208;6809.591424514545;6810.6254156020905;6819.079424277659;6819.113515243086;6830.146231721035;6830.487713421513;6838.042674025641;6620.933790662032;6627.271000189879;6627.641333526712;6630.7679231226675;6632.336766323329;6393.232812062396;6597.60414375139;6617.536772426077;6618.63597502142;6620.304867988792;6837.453003759588;6893.827654308482;6894;6897.068895699016;6904.620245886525;4467.642588592969;4492.9775351123035;4495.595396414338;4499.167653984024;4514.864554063383;6493.707783149675;6584.04531342943;6647.335266473314;6658.400743933069;6661;6458.644774537258;6463.86882295587;6466.094746735367;6467.935320646733;6469.708863101077;6399.616023038632;6447.2263328400895;6449.548531602931;6452.419282264619;6466.06242094903;6137.84655383619;6330.715117819617;6343.302236754045;6344.841378965562;6360.713767880364;6467.482601391972;6473.2232132144445;6479.060536222127;6479.935200648122;6499.512536559682;6187.690615469299;6334.936650633619;6348.746050157942;6348.936510634834;6352.555321127476 21:39:18 INFO - 2015-11-19 21:39:18,076 DEBUG : BROWSER_OUTPUT: |5;yui.html;808.5916612110883;822.2846123872232;822.6154596003307;836.1011912194392;854;13020.869791302084;13302.334883255835;13322.267275299855;13330.133541319807;13337.933310333447;12532.874671253285;12622.68443288916;12624.305663188521;12643.367831608406;12646.494140234403;677.0183234310246;682.604089628017;805.6133056133074;809.34038758412;823.8187598728271;820.9753707388788;820.983580328393;829.7178959153887;829.7759604906671;830.3772170871846;700.5761514283836;861.28513333933;867.9218870301671;868.4702331577732;868.6525389844081;709.5033476566424;844.5481667307992;866.3372520022189;868.6481974800216;869.8695195720693;619.6406084470996;620.8696173803506;626.3892704613012;626.683524819963;627.9058141278845;12735.936320318431;12854.228746275254;12957.222566645936;12988.935055324662;12992.740145197044;11543.249688770204;11579.421028948518;11882.881171188264;12411;12427.254364738144;10129.290949633529;10351.792964140675;10413.635522756667;10481.371117732884;10492.632757853515;3648.2703459308245;3703.407454807245;3720.1629633332554;3720.7395482316247;3730.5896351401325;42838.143237135395;43271.567284327386;43321.35017974733;43383.52931765451;43472.565274347166;10051.748706282255;10116.898831011596;10147.441890696082;10368.688939331832;10382.948085259677;17722.556936076442;17755.46733597994;17769.11154442273;18464.169112389976;18503.81496185048;7566.508176968479;7617.809554761176;7904.6838126474295;7909.05091389037;7937.761867143995;3961.7028722845903;3967.1668949520345;3976.741511801724;4042.413849991735;4076.0421300994244;2987.731104200632;3037.271054946841;3043.8630261638277;3044.1476386611785;3048.5122380419025;555.4084899581933;558.0206737176311;561.7022977821761;566.2157911292807;575.5999580291657;640.1869625575494;664.1797380235405;670.4267850987433;672.314239475732;688.5111570784699;8831.779205519913;8876;8899.421537600036;8918.821623567492;8929.196372326393;635.1203583037526;667.9098321726602;671.7615246587488;679.4734081087197;697.7906628011576;3923.9925826969566;4087.570805065485;4097.078157414558;4248.681348898845;4559.726416415026;54696;54940.72529637326;54961.450385495635;55028.72485637546;56940.14589781156;46481.30278045832;46525;49029.26456103161;51436.74281628643;51505.48494515082;46081.7695911525;46276;47129.764351178026;47231;47297.763511182915;8713.956430217808;8754.91245087541;8982.550872456482;9056.184943355129;9176.908230917872;32708.672913271515;32917.67082329146;33558.66441335653;33572;33948.64205431854;40075.599244007186;40360.59639403568;40411.1917761649;41461.37807932823;41871.7906410466;10336.844947325946;10466.215033872339;10754.354738715701;10825.404602746925;10974.341539507655;11716.179867409199;12138.696532586757;12172.147949643795;12179.330136842558;12455.93772031134;10825.512851921525;11201.948164898438;11259.943700281447;11375.31748095117;11720.589779357682;10876.238663293494;11181.32912025281;11264.549418023187;11488.885111149117;11565.710857228636;10975.780484390109;10989.285696429706;11026.944865275622;11362.261453005529;11364.715882103013;9556.85238896357;9900.257480688833;9905.950470247602;9930.106290433896;10210.642627508001;9064.320175986695;9152.633894644407;9715.22278217755;10089.89910100919;10124.949375253076 21:39:18 INFO - 2015-11-19 21:39:18,076 DEBUG : BROWSER_OUTPUT: __end_tp_report 21:39:18 INFO - 2015-11-19 21:39:18,077 DEBUG : BROWSER_OUTPUT: __start_cc_report 21:39:18 INFO - 2015-11-19 21:39:18,077 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,836 21:39:18 INFO - 2015-11-19 21:39:18,077 DEBUG : BROWSER_OUTPUT: __end_cc_report 21:39:18 INFO - 2015-11-19 21:39:18,077 DEBUG : BROWSER_OUTPUT: __startTimestamp1447997958064__endTimestamp 21:39:18 INFO - 2015-11-19 21:39:18,077 DEBUG : BROWSER_OUTPUT: 21:39:18 INFO - 2015-11-19 21:39:18,077 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 21:39:18 INFO - 2015-11-19 21:39:18,077 DEBUG : BROWSER_OUTPUT: Number of tests: 6 21:39:18 INFO - 2015-11-19 21:39:18,078 DEBUG : BROWSER_OUTPUT: 21:39:18 INFO - 2015-11-19 21:39:18,078 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5490.08 Median:5707.51 stddev:603.41 (10.6%) stddev-sans-first:577.22 21:39:18 INFO - 2015-11-19 21:39:18,078 DEBUG : BROWSER_OUTPUT: Values: 3172.1 3288.2 3307.1 3316.0 3358.5 5294.0 5468.5 5507.9 5516.4 5544.9 5435.8 5448.6 5492.4 5506.4 5561.2 4974.1 4992.8 5022.3 5029.1 5062.6 4947.8 5128.1 5145.8 5172.5 5211.1 4931.6 4983.8 5026.6 5034.6 5049.6 4992.3 5057.4 5075.5 5095.0 5110.3 4947.5 5043.4 5055.1 5065.5 5086.2 5335.8 5377.0 5405.8 5420.0 5433.0 5912.8 5923.7 5930.6 5936.9 5938.0 5693.1 5792.0 5910.8 5926.3 5936.8 5406.4 5514.3 5516.4 5518.1 5595.2 6004.2 6005.5 6018.1 6058.3 6114.6 5752.5 5808.3 5812.1 5812.9 5858.0 5810.7 5811.4 5918.3 5923.4 5932.8 5863.0 5868.4 5890.0 5926.0 5956.7 5821.4 5839.4 5856.0 5857.9 5878.9 4399.2 4449.4 4527.0 4530.3 4539.4 4045.5 4073.4 4087.5 4092.8 4095.0 5657.6 5686.4 5687.9 5696.1 5707.5 5720.0 5833.4 5836.4 5837.4 6083.7 5583.4 5592.4 5632.8 5669.0 5671.9 5194.3 5222.7 5235.2 5237.7 5239.4 5890.2 5954.7 6174.1 6182.1 6208.8 5827.4 5893.0 5904.3 5954.2 5979.5 6056.0 6056.1 6076.1 6076.4 6195.6 5693.1 5780.1 5789.6 5804.9 5829.8 5693.2 5757.2 5760.5 5766.5 5813.7 5869.9 5869.9 5875.5 5883.0 5897.1 5782.9 5835.0 5842.2 5852.2 5858.2 5430.5 5503.4 5547.5 5561.1 5663.7 5815.3 5857.3 5903.8 5949.8 5963.6 5721.6 5751.0 5786.1 5788.4 5790.5 21:39:18 INFO - 2015-11-19 21:39:18,078 DEBUG : BROWSER_OUTPUT: 21:39:18 INFO - 2015-11-19 21:39:18,078 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:49038.87 Median:180072.84 stddev:85112.04 (47.3%) stddev-sans-first:85273.03 21:39:18 INFO - 2015-11-19 21:39:18,079 DEBUG : BROWSER_OUTPUT: Values: 578.3 592.0 598.7 599.8 611.1 31283.8 32061.8 32070.8 32086.2 32143.7 40326.6 41217.2 41238.0 41289.2 41322.8 8881.6 9053.5 9059.5 9059.7 9060.5 7815.2 8001.3 8005.6 8844.6 8958.6 10762.9 10990.6 10991.4 11013.8 11030.8 10510.6 10545.4 10582.5 10629.5 10640.2 7813.0 7995.4 10378.2 10524.4 10608.7 39996.0 40412.6 40434.8 40436.2 40467.8 3355.3 3588.9 3742.5 3897.3 4083.0 30485.5 30874.7 31272.8 31323.0 31398.7 3938.3 3969.5 3978.0 4030.3 4037.7 299586.0 303235.0 304659.0 421409.0 426038.0 55846.4 56465.3 56490.4 56556.7 56557.4 61642.7 61846.0 62093.1 62317.7 62355.7 14696.6 14893.2 14909.4 14983.8 15092.2 12082.0 12233.8 12235.7 12245.1 12251.0 20176.8 20381.5 20414.6 20452.5 20485.6 7495.6 7677.6 7692.5 7701.1 7763.1 916.7 957.8 996.3 1002.7 1024.7 29878.3 29913.7 29996.3 30077.5 30245.0 1014.5 1034.1 1040.9 1043.0 1077.9 15114.6 15329.5 15604.4 15612.7 15618.3 320451.0 323753.0 325198.0 327554.0 327952.0 54001.7 54263.2 54319.0 54419.0 54424.0 1332.5 1344.7 1363.5 1365.0 1368.9 28701.6 29303.6 30125.7 30334.0 31233.4 47453.0 47881.5 47889.8 47893.3 47927.0 273821.0 278919.0 294816.0 299081.0 299840.0 30779.0 30813.8 30991.4 31056.4 31144.0 44118.3 45226.3 45291.0 45889.3 46244.8 37476.6 37830.6 38453.2 38934.4 39210.6 36175.3 36916.4 37616.2 38708.6 38859.8 33316.3 33419.7 36483.0 37144.6 37233.0 28998.9 32214.5 32329.5 32409.5 32591.7 24678.7 24801.5 24928.6 25044.1 25376.4 21:39:18 INFO - 2015-11-19 21:39:18,079 DEBUG : BROWSER_OUTPUT: 21:39:18 INFO - 2015-11-19 21:39:18,080 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25664.17 Median:4084.90 stddev:73119.31 (1790.0%) stddev-sans-first:73299.73 21:39:18 INFO - 2015-11-19 21:39:18,080 DEBUG : BROWSER_OUTPUT: Values: 355.3 357.3 357.6 357.6 358.9 13741.5 14146.0 16160.5 16384.7 17073.2 14616.7 15943.3 15957.3 15984.9 16944.5 5352.8 5509.1 5510.2 5513.3 5515.4 3995.8 4063.3 5442.2 5480.2 5893.3 5951.6 5978.3 6004.0 6007.6 6008.4 5028.8 5160.3 5162.8 5163.0 5959.0 4919.4 4960.1 4960.2 4981.3 5067.5 12221.2 12316.1 12403.8 15621.7 19816.3 2053.5 2066.4 2072.4 2098.5 2202.0 8973.9 9766.4 12193.9 12334.6 12619.7 1759.7 1783.2 1786.1 1821.3 1847.6 59435.0 61418.4 62432.4 62701.4 62746.0 9714.8 9957.6 9965.9 9980.3 10039.5 13204.8 13232.5 13275.5 13276.9 13281.6 7114.5 7145.9 7364.9 7469.7 7489.1 6462.1 6481.4 6503.3 6523.3 6546.6 4080.1 4089.7 4098.7 4189.9 4245.2 1621.6 1691.7 1697.2 2743.3 2843.4 833.6 908.8 921.2 937.7 1076.7 16590.2 17051.4 17389.8 17409.3 17522.7 436.9 437.2 448.9 919.5 1018.9 5461.0 5817.5 5840.1 5893.8 5935.7 358006.0 364857.0 407694.0 527807.0 531869.0 79623.0 83296.0 84638.0 84671.0 84696.0 471.7 485.1 486.0 486.0 486.6 9993.9 10016.0 10035.5 10071.8 10132.0 34091.5 34943.5 35355.6 35474.0 35966.3 46027.1 46321.8 47308.5 47487.0 47570.0 9417.8 9445.3 9455.6 9626.2 9634.6 17044.1 17105.9 17159.3 17308.4 17952.6 13799.4 14775.7 14854.6 14869.8 15012.3 14543.9 14637.3 14777.3 14808.5 15294.5 14467.3 14890.9 15092.8 15179.5 15701.0 9400.0 9435.7 9581.1 9610.2 9636.6 2803.3 11338.7 13024.2 14607.6 14892.0 21:39:18 INFO - 2015-11-19 21:39:18,080 DEBUG : BROWSER_OUTPUT: 21:39:18 INFO - 2015-11-19 21:39:18,080 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5305.38 Median:6183.82 stddev:2751.59 (44.5%) stddev-sans-first:2742.91 21:39:18 INFO - 2015-11-19 21:39:18,081 DEBUG : BROWSER_OUTPUT: Values: 1309.1 1638.7 1698.2 1716.5 1728.4 6463.4 7445.3 7596.1 7599.4 7600.5 7401.0 7514.9 7517.7 7528.6 7528.6 2170.5 2188.9 2193.7 2197.7 2197.8 2231.9 2239.8 2244.5 2255.2 2265.2 2160.7 2187.9 2190.6 2192.8 2193.2 2169.8 2176.0 2176.2 2178.5 2178.6 2236.9 2283.5 2285.1 2285.4 2286.8 6558.0 6762.0 7482.1 7524.2 7539.2 4427.4 4550.7 4554.0 4559.9 4565.2 3054.1 3069.3 3097.4 3104.7 3211.1 1090.9 1116.4 1136.7 1141.6 1144.5 10344.5 10613.7 10632.7 10634.8 10637.3 4057.3 4097.2 4136.9 4137.2 4142.6 8617.8 8638.6 8640.9 8644.7 8649.7 4609.9 4624.2 4635.9 4637.1 4638.5 4257.8 4264.1 4269.3 4273.7 4275.3 3429.3 3437.0 3440.8 3447.3 3464.4 1038.2 1051.9 1054.6 1057.5 1060.3 1286.6 1296.4 1310.9 1341.0 1341.3 7239.4 7250.9 7317.8 7319.0 7348.2 458.6 469.5 481.7 482.6 483.6 5084.9 5408.6 5454.5 5458.5 5473.7 8271.5 9028.3 9163.3 9278.0 9278.6 8884.6 9040.4 9049.5 9121.2 9165.0 7089.1 7160.1 7181.0 7186.9 7206.2 6958.0 6998.1 7011.5 7045.2 7067.2 7854.1 7876.7 8061.6 8092.8 8097.2 8041.2 8142.0 8154.7 8259.5 8290.5 7034.2 7122.9 7135.9 7141.6 7146.4 7245.8 7390.1 7393.5 7423.5 7433.7 6766.0 6773.9 6812.4 6817.1 6849.6 6829.9 6954.0 6958.6 7027.6 7062.1 6870.8 6961.7 6978.7 6982.2 6995.8 6425.7 6442.7 6448.4 6466.8 6470.7 6126.5 6241.2 6242.8 6257.3 6440.7 21:39:18 INFO - 2015-11-19 21:39:18,081 DEBUG : BROWSER_OUTPUT: 21:39:18 INFO - 2015-11-19 21:39:18,082 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5337.44 Median:6102.24 stddev:1626.28 (26.7%) stddev-sans-first:1586.61 21:39:18 INFO - 2015-11-19 21:39:18,082 DEBUG : BROWSER_OUTPUT: Values: 318.4 323.9 325.5 328.8 336.1 5975.3 5979.2 5991.7 6037.6 6073.1 5705.3 5796.6 5847.3 5924.2 5956.5 4558.2 4580.1 4582.0 4582.6 4595.1 4407.6 4583.8 4593.4 4595.7 4596.3 4429.4 4491.5 4520.1 4532.9 4538.6 4444.6 4494.7 4507.9 4511.1 4512.3 3987.4 4008.2 4010.9 4013.6 4014.3 5478.3 5653.6 5662.2 5664.6 5668.5 5287.8 5301.3 5318.5 5318.7 5322.7 6342.4 6342.6 6343.9 6347.8 6350.7 4460.6 4463.4 4465.4 4465.9 4477.5 6417.3 6586.0 6587.0 6589.9 6597.6 4446.8 4481.1 4481.3 4483.6 4486.7 4537.3 4537.6 4538.9 4542.3 4543.2 5263.6 5264.5 5264.7 5272.1 5276.2 6253.5 6386.7 6388.8 6400.3 6408.2 1579.8 1592.9 1597.2 1598.8 1599.1 1042.7 1050.0 1059.5 1067.9 1068.7 6204.8 6208.0 6212.9 6214.9 6216.9 6589.8 6592.2 6593.7 6605.1 6619.5 6030.8 6131.3 6183.4 6276.2 6295.8 3568.3 3578.6 3586.2 3594.7 3595.7 6843.9 6857.7 6861.1 6862.0 6868.8 6602.0 6789.0 6800.7 6809.6 6810.6 6819.1 6819.1 6830.1 6830.5 6838.0 6620.9 6627.3 6627.6 6630.8 6632.3 6393.2 6597.6 6617.5 6618.6 6620.3 6837.5 6893.8 6894.0 6897.1 6904.6 4467.6 4493.0 4495.6 4499.2 4514.9 6493.7 6584.0 6647.3 6658.4 6661.0 6458.6 6463.9 6466.1 6467.9 6469.7 6399.6 6447.2 6449.5 6452.4 6466.1 6137.8 6330.7 6343.3 6344.8 6360.7 6467.5 6473.2 6479.1 6479.9 6499.5 6187.7 6334.9 6348.7 6348.9 6352.6 21:39:18 INFO - 2015-11-19 21:39:18,082 DEBUG : BROWSER_OUTPUT: 21:39:18 INFO - 2015-11-19 21:39:18,082 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13363.99 Median:23060.24 stddev:15109.31 (65.5%) stddev-sans-first:15122.27 21:39:18 INFO - 2015-11-19 21:39:18,082 DEBUG : BROWSER_OUTPUT: Values: 808.6 822.3 822.6 836.1 854.0 13020.9 13302.3 13322.3 13330.1 13337.9 12532.9 12622.7 12624.3 12643.4 12646.5 677.0 682.6 805.6 809.3 823.8 821.0 821.0 829.7 829.8 830.4 700.6 861.3 867.9 868.5 868.7 709.5 844.5 866.3 868.6 869.9 619.6 620.9 626.4 626.7 627.9 12735.9 12854.2 12957.2 12988.9 12992.7 11543.2 11579.4 11882.9 12411.0 12427.3 10129.3 10351.8 10413.6 10481.4 10492.6 3648.3 3703.4 3720.2 3720.7 3730.6 42838.1 43271.6 43321.4 43383.5 43472.6 10051.7 10116.9 10147.4 10368.7 10382.9 17722.6 17755.5 17769.1 18464.2 18503.8 7566.5 7617.8 7904.7 7909.1 7937.8 3961.7 3967.2 3976.7 4042.4 4076.0 2987.7 3037.3 3043.9 3044.1 3048.5 555.4 558.0 561.7 566.2 575.6 640.2 664.2 670.4 672.3 688.5 8831.8 8876.0 8899.4 8918.8 8929.2 635.1 667.9 671.8 679.5 697.8 3924.0 4087.6 4097.1 4248.7 4559.7 54696.0 54940.7 54961.5 55028.7 56940.1 46481.3 46525.0 49029.3 51436.7 51505.5 46081.8 46276.0 47129.8 47231.0 47297.8 8714.0 8754.9 8982.6 9056.2 9176.9 32708.7 32917.7 33558.7 33572.0 33948.6 40075.6 40360.6 40411.2 41461.4 41871.8 10336.8 10466.2 10754.4 10825.4 10974.3 11716.2 12138.7 12172.1 12179.3 12455.9 10825.5 11201.9 11259.9 11375.3 11720.6 10876.2 11181.3 11264.5 11488.9 11565.7 10975.8 10989.3 11026.9 11362.3 11364.7 9556.9 9900.3 9906.0 9930.1 10210.6 9064.3 9152.6 9715.2 10089.9 10124.9 21:39:18 INFO - 2015-11-19 21:39:18,082 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 21:39:18 INFO - 2015-11-19 21:39:18,082 DEBUG : BROWSER_OUTPUT: 21:39:18 INFO - 2015-11-19 21:39:18,757 INFO : Browser exited with error code: 0 21:39:18 INFO - 2015-11-19 21:39:18,781 INFO : Completed test dromaeo_css (00:18:33) 21:39:18 INFO - 2015-11-19 21:39:18,781 INFO : Starting test kraken 21:39:18 INFO - 2015-11-19 21:39:18,781 DEBUG : operating with platform_type : linux_ 21:39:18 INFO - 2015-11-19 21:39:18,781 INFO : Initialising browser for kraken test... 21:39:18 INFO - 2015-11-19 21:39:18,787 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpqt24jO/profile http://localhost:59757/getInfo.html 21:39:22 INFO - 2015-11-19 21:39:22,701 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 21:39:22 INFO - 2015-11-19 21:39:22,701 DEBUG : BROWSER_OUTPUT: colorDepth:24 21:39:22 INFO - 2015-11-19 21:39:22,701 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 21:39:22 INFO - 2015-11-19 21:39:22,701 DEBUG : BROWSER_OUTPUT: __metrics 21:39:22 INFO - 2015-11-19 21:39:22,802 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:39:24 INFO - 2015-11-19 21:39:24,106 INFO : Browser initialized. 21:39:24 INFO - 2015-11-19 21:39:24,107 INFO : Running cycle 1/1 for kraken test... 21:39:24 INFO - 2015-11-19 21:39:24,107 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpqt24jO/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 21:39:35 INFO - 2015-11-19 21:39:35,936 DEBUG : BROWSER_OUTPUT: RSS: Main: 142344192 21:39:35 INFO - 2015-11-19 21:39:35,936 DEBUG : BROWSER_OUTPUT: 21:39:38 INFO - 2015-11-19 21:39:38,396 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59757/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59757/tests/kraken/driver.html?testName=audio-beat-detection) 21:39:38 INFO - 2015-11-19 21:39:38,977 DEBUG : BROWSER_OUTPUT: RSS: Main: 178061312 21:39:38 INFO - 2015-11-19 21:39:38,978 DEBUG : BROWSER_OUTPUT: 21:39:41 INFO - 2015-11-19 21:39:41,614 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59757/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59757/tests/kraken/driver.html?testName=audio-dft) 21:39:42 INFO - 2015-11-19 21:39:42,179 DEBUG : BROWSER_OUTPUT: RSS: Main: 167157760 21:39:42 INFO - 2015-11-19 21:39:42,180 DEBUG : BROWSER_OUTPUT: 21:39:45 INFO - 2015-11-19 21:39:45,099 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59757/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59757/tests/kraken/driver.html?testName=audio-fft) 21:39:45 INFO - 2015-11-19 21:39:45,653 DEBUG : BROWSER_OUTPUT: RSS: Main: 150851584 21:39:45 INFO - 2015-11-19 21:39:45,653 DEBUG : BROWSER_OUTPUT: 21:39:47 INFO - 2015-11-19 21:39:47,630 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59757/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59757/tests/kraken/driver.html?testName=audio-oscillator) 21:39:48 INFO - 2015-11-19 21:39:48,196 DEBUG : BROWSER_OUTPUT: RSS: Main: 153784320 21:39:48 INFO - 2015-11-19 21:39:48,196 DEBUG : BROWSER_OUTPUT: 21:39:50 INFO - 2015-11-19 21:39:50,348 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59757/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59757/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:39:50 INFO - 2015-11-19 21:39:50,901 DEBUG : BROWSER_OUTPUT: RSS: Main: 156614656 21:39:50 INFO - 2015-11-19 21:39:50,902 DEBUG : BROWSER_OUTPUT: 21:39:53 INFO - 2015-11-19 21:39:53,820 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59757/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59757/tests/kraken/driver.html?testName=imaging-darkroom) 21:39:54 INFO - 2015-11-19 21:39:54,395 DEBUG : BROWSER_OUTPUT: RSS: Main: 155369472 21:39:54 INFO - 2015-11-19 21:39:54,395 DEBUG : BROWSER_OUTPUT: 21:39:57 INFO - 2015-11-19 21:39:57,798 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59757/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59757/tests/kraken/driver.html?testName=imaging-desaturate) 21:39:58 INFO - 2015-11-19 21:39:58,368 DEBUG : BROWSER_OUTPUT: RSS: Main: 157343744 21:39:58 INFO - 2015-11-19 21:39:58,368 DEBUG : BROWSER_OUTPUT: 21:40:01 INFO - 2015-11-19 21:40:01,097 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59757/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59757/tests/kraken/driver.html?testName=json-parse-financial) 21:40:01 INFO - 2015-11-19 21:40:01,663 DEBUG : BROWSER_OUTPUT: RSS: Main: 157736960 21:40:01 INFO - 2015-11-19 21:40:01,663 DEBUG : BROWSER_OUTPUT: 21:40:03 INFO - 2015-11-19 21:40:03,279 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59757/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59757/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:40:03 INFO - 2015-11-19 21:40:03,840 DEBUG : BROWSER_OUTPUT: RSS: Main: 168067072 21:40:03 INFO - 2015-11-19 21:40:03,841 DEBUG : BROWSER_OUTPUT: 21:40:05 INFO - 2015-11-19 21:40:05,655 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59757/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59757/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:40:06 INFO - 2015-11-19 21:40:06,257 DEBUG : BROWSER_OUTPUT: RSS: Main: 163639296 21:40:06 INFO - 2015-11-19 21:40:06,257 DEBUG : BROWSER_OUTPUT: 21:40:08 INFO - 2015-11-19 21:40:08,343 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59757/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59757/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:40:08 INFO - 2015-11-19 21:40:08,925 DEBUG : BROWSER_OUTPUT: RSS: Main: 171708416 21:40:08 INFO - 2015-11-19 21:40:08,925 DEBUG : BROWSER_OUTPUT: 21:40:11 INFO - 2015-11-19 21:40:11,327 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59757/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59757/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:40:11 INFO - 2015-11-19 21:40:11,909 DEBUG : BROWSER_OUTPUT: RSS: Main: 178900992 21:40:11 INFO - 2015-11-19 21:40:11,909 DEBUG : BROWSER_OUTPUT: 21:40:14 INFO - 2015-11-19 21:40:14,464 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59757/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59757/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:40:15 INFO - 2015-11-19 21:40:15,030 DEBUG : BROWSER_OUTPUT: RSS: Main: 177532928 21:40:15 INFO - 2015-11-19 21:40:15,030 DEBUG : BROWSER_OUTPUT: 21:40:16 INFO - 2015-11-19 21:40:16,699 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59757/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59757/tests/kraken/driver.html?testName=ai-astar) 21:40:16 INFO - 2015-11-19 21:40:16,941 DEBUG : BROWSER_OUTPUT: RSS: Main: 237142016 21:40:16 INFO - 2015-11-19 21:40:16,941 DEBUG : BROWSER_OUTPUT: 21:40:16 INFO - 2015-11-19 21:40:16,945 DEBUG : BROWSER_OUTPUT: __start_tp_report 21:40:16 INFO - 2015-11-19 21:40:16,945 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 21:40:16 INFO - 2015-11-19 21:40:16,945 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 21:40:16 INFO - 2015-11-19 21:40:16,945 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 21:40:16 INFO - 2015-11-19 21:40:16,945 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;111;102;111;111;112;100;110;110;110 21:40:16 INFO - 2015-11-19 21:40:16,946 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;161;126;154;166;126;151;160;125;166;125 21:40:16 INFO - 2015-11-19 21:40:16,946 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;159;160;159;158;160;160;162;161;161 21:40:16 INFO - 2015-11-19 21:40:16,946 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;73;93;99;72;72;72;97;90;72 21:40:16 INFO - 2015-11-19 21:40:16,946 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;90;90;134;90;91;91;136;91;90;137 21:40:16 INFO - 2015-11-19 21:40:16,946 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;109;109;110;109;109;110;110;109 21:40:16 INFO - 2015-11-19 21:40:16,946 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;146;146;145;146;146;146;145;144;144 21:40:16 INFO - 2015-11-19 21:40:16,946 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;97;96;96;96;95;95;96;95 21:40:16 INFO - 2015-11-19 21:40:16,947 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;68;65;64;65;64;66;65;71;63;66 21:40:16 INFO - 2015-11-19 21:40:16,947 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;68;68;68;68;69;77;69;69;70 21:40:16 INFO - 2015-11-19 21:40:16,947 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;83;92;84;86;84;84;86;86;84 21:40:16 INFO - 2015-11-19 21:40:16,947 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;123;122;116;116;122;121;125;113;117;133 21:40:16 INFO - 2015-11-19 21:40:16,947 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;142;142;155;150;154;142;152;149;148;143 21:40:16 INFO - 2015-11-19 21:40:16,947 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;67;66;66;67;67;67;65;67;66;67 21:40:16 INFO - 2015-11-19 21:40:16,947 DEBUG : BROWSER_OUTPUT: __end_tp_report 21:40:16 INFO - 2015-11-19 21:40:16,947 DEBUG : BROWSER_OUTPUT: __start_cc_report 21:40:16 INFO - 2015-11-19 21:40:16,948 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,913 21:40:16 INFO - 2015-11-19 21:40:16,948 DEBUG : BROWSER_OUTPUT: __end_cc_report 21:40:16 INFO - 2015-11-19 21:40:16,948 DEBUG : BROWSER_OUTPUT: __startTimestamp1447998016943__endTimestamp 21:40:16 INFO - 2015-11-19 21:40:16,948 DEBUG : BROWSER_OUTPUT: 21:40:16 INFO - 2015-11-19 21:40:16,951 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 21:40:16 INFO - 2015-11-19 21:40:16,951 DEBUG : BROWSER_OUTPUT: Number of tests: 14 21:40:16 INFO - 2015-11-19 21:40:16,952 DEBUG : BROWSER_OUTPUT: 21:40:16 INFO - 2015-11-19 21:40:16,952 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.70 Median:110.50 stddev:4.14 (3.7%) stddev-sans-first:4.36 21:40:16 INFO - 2015-11-19 21:40:16,952 DEBUG : BROWSER_OUTPUT: Values: 110.0 111.0 102.0 111.0 111.0 112.0 100.0 110.0 110.0 110.0 21:40:16 INFO - 2015-11-19 21:40:16,952 DEBUG : BROWSER_OUTPUT: 21:40:16 INFO - 2015-11-19 21:40:16,952 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:146.00 Median:157.00 stddev:18.23 (11.6%) stddev-sans-first:18.51 21:40:16 INFO - 2015-11-19 21:40:16,952 DEBUG : BROWSER_OUTPUT: Values: 161.0 126.0 154.0 166.0 126.0 151.0 160.0 125.0 166.0 125.0 21:40:16 INFO - 2015-11-19 21:40:16,952 DEBUG : BROWSER_OUTPUT: 21:40:16 INFO - 2015-11-19 21:40:16,952 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.10 Median:160.50 stddev:1.20 (0.7%) stddev-sans-first:1.22 21:40:16 INFO - 2015-11-19 21:40:16,952 DEBUG : BROWSER_OUTPUT: Values: 161.0 159.0 160.0 159.0 158.0 160.0 160.0 162.0 161.0 161.0 21:40:16 INFO - 2015-11-19 21:40:16,952 DEBUG : BROWSER_OUTPUT: 21:40:16 INFO - 2015-11-19 21:40:16,952 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.10 Median:81.50 stddev:11.99 (14.7%) stddev-sans-first:12.14 21:40:16 INFO - 2015-11-19 21:40:16,952 DEBUG : BROWSER_OUTPUT: Values: 71.0 73.0 93.0 99.0 72.0 72.0 72.0 97.0 90.0 72.0 21:40:16 INFO - 2015-11-19 21:40:16,952 DEBUG : BROWSER_OUTPUT: 21:40:16 INFO - 2015-11-19 21:40:16,952 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.00 Median:90.00 stddev:21.87 (24.3%) stddev-sans-first:22.60 21:40:16 INFO - 2015-11-19 21:40:16,952 DEBUG : BROWSER_OUTPUT: Values: 90.0 90.0 134.0 90.0 91.0 91.0 136.0 91.0 90.0 137.0 21:40:16 INFO - 2015-11-19 21:40:16,953 DEBUG : BROWSER_OUTPUT: 21:40:16 INFO - 2015-11-19 21:40:16,953 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 21:40:16 INFO - 2015-11-19 21:40:16,953 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 109.0 109.0 110.0 109.0 109.0 110.0 110.0 109.0 21:40:16 INFO - 2015-11-19 21:40:16,953 DEBUG : BROWSER_OUTPUT: 21:40:16 INFO - 2015-11-19 21:40:16,953 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.30 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 21:40:16 INFO - 2015-11-19 21:40:16,953 DEBUG : BROWSER_OUTPUT: Values: 145.0 146.0 146.0 145.0 146.0 146.0 146.0 145.0 144.0 144.0 21:40:16 INFO - 2015-11-19 21:40:16,953 DEBUG : BROWSER_OUTPUT: 21:40:16 INFO - 2015-11-19 21:40:16,953 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.67 21:40:16 INFO - 2015-11-19 21:40:16,953 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 97.0 96.0 96.0 96.0 95.0 95.0 96.0 95.0 21:40:16 INFO - 2015-11-19 21:40:16,953 DEBUG : BROWSER_OUTPUT: 21:40:16 INFO - 2015-11-19 21:40:16,953 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:65.70 Median:65.50 stddev:2.31 (3.5%) stddev-sans-first:2.30 21:40:16 INFO - 2015-11-19 21:40:16,953 DEBUG : BROWSER_OUTPUT: Values: 68.0 65.0 64.0 65.0 64.0 66.0 65.0 71.0 63.0 66.0 21:40:16 INFO - 2015-11-19 21:40:16,953 DEBUG : BROWSER_OUTPUT: 21:40:16 INFO - 2015-11-19 21:40:16,953 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.40 Median:69.00 stddev:2.76 (4.0%) stddev-sans-first:2.88 21:40:16 INFO - 2015-11-19 21:40:16,953 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 68.0 68.0 68.0 69.0 77.0 69.0 69.0 70.0 21:40:16 INFO - 2015-11-19 21:40:16,953 DEBUG : BROWSER_OUTPUT: 21:40:16 INFO - 2015-11-19 21:40:16,954 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.40 Median:85.50 stddev:2.55 (3.0%) stddev-sans-first:2.70 21:40:16 INFO - 2015-11-19 21:40:16,954 DEBUG : BROWSER_OUTPUT: Values: 85.0 83.0 92.0 84.0 86.0 84.0 84.0 86.0 86.0 84.0 21:40:16 INFO - 2015-11-19 21:40:16,954 DEBUG : BROWSER_OUTPUT: 21:40:16 INFO - 2015-11-19 21:40:16,954 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:120.80 Median:122.00 stddev:5.73 (4.7%) stddev-sans-first:6.02 21:40:16 INFO - 2015-11-19 21:40:16,954 DEBUG : BROWSER_OUTPUT: Values: 123.0 122.0 116.0 116.0 122.0 121.0 125.0 113.0 117.0 133.0 21:40:16 INFO - 2015-11-19 21:40:16,954 DEBUG : BROWSER_OUTPUT: 21:40:16 INFO - 2015-11-19 21:40:16,954 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.70 Median:149.50 stddev:5.14 (3.4%) stddev-sans-first:5.02 21:40:16 INFO - 2015-11-19 21:40:16,954 DEBUG : BROWSER_OUTPUT: Values: 142.0 142.0 155.0 150.0 154.0 142.0 152.0 149.0 148.0 143.0 21:40:16 INFO - 2015-11-19 21:40:16,954 DEBUG : BROWSER_OUTPUT: 21:40:16 INFO - 2015-11-19 21:40:16,954 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:67.00 stddev:0.71 (1.1%) stddev-sans-first:0.73 21:40:16 INFO - 2015-11-19 21:40:16,954 DEBUG : BROWSER_OUTPUT: Values: 67.0 66.0 66.0 67.0 67.0 67.0 65.0 67.0 66.0 67.0 21:40:16 INFO - 2015-11-19 21:40:16,954 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 21:40:16 INFO - 2015-11-19 21:40:16,954 DEBUG : BROWSER_OUTPUT: 21:40:17 INFO - 2015-11-19 21:40:17,753 INFO : Browser exited with error code: 0 21:40:17 INFO - 2015-11-19 21:40:17,814 INFO : Completed test kraken (00:00:59) 21:40:17 INFO - 2015-11-19 21:40:17,815 INFO : Starting test v8_7 21:40:17 INFO - 2015-11-19 21:40:17,815 DEBUG : operating with platform_type : linux_ 21:40:17 INFO - 2015-11-19 21:40:17,815 INFO : Initialising browser for v8_7 test... 21:40:17 INFO - 2015-11-19 21:40:17,821 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpB6MKQy/profile http://localhost:59757/getInfo.html 21:40:21 INFO - 2015-11-19 21:40:21,756 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 21:40:21 INFO - 2015-11-19 21:40:21,756 DEBUG : BROWSER_OUTPUT: colorDepth:24 21:40:21 INFO - 2015-11-19 21:40:21,756 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 21:40:21 INFO - 2015-11-19 21:40:21,756 DEBUG : BROWSER_OUTPUT: __metrics 21:40:21 INFO - 2015-11-19 21:40:21,837 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:40:23 INFO - 2015-11-19 21:40:23,240 INFO : Browser initialized. 21:40:23 INFO - 2015-11-19 21:40:23,241 INFO : Running cycle 1/1 for v8_7 test... 21:40:23 INFO - 2015-11-19 21:40:23,241 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpB6MKQy/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 21:40:35 INFO - 2015-11-19 21:40:35,001 DEBUG : BROWSER_OUTPUT: RSS: Main: 142032896 21:40:35 INFO - 2015-11-19 21:40:35,002 DEBUG : BROWSER_OUTPUT: 21:40:56 INFO - 2015-11-19 21:40:56,382 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59757/tests/v8_7/run.html (next: http://localhost:59757/tests/v8_7/run.html) 21:40:56 INFO - 2015-11-19 21:40:56,632 DEBUG : BROWSER_OUTPUT: RSS: Main: 545910784 21:40:56 INFO - 2015-11-19 21:40:56,632 DEBUG : BROWSER_OUTPUT: 21:40:56 INFO - 2015-11-19 21:40:56,634 DEBUG : BROWSER_OUTPUT: __start_tp_report 21:40:56 INFO - 2015-11-19 21:40:56,634 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 21:40:56 INFO - 2015-11-19 21:40:56,634 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 21:40:56 INFO - 2015-11-19 21:40:56,634 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 21:40:56 INFO - 2015-11-19 21:40:56,635 DEBUG : BROWSER_OUTPUT: |0;Richards;163.21201240411295 21:40:56 INFO - 2015-11-19 21:40:56,635 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;193.91118867558657 21:40:56 INFO - 2015-11-19 21:40:56,635 DEBUG : BROWSER_OUTPUT: |2;Encrypt;286.697247706422 21:40:56 INFO - 2015-11-19 21:40:56,635 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5025.125628140703 21:40:56 INFO - 2015-11-19 21:40:56,635 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1957.03125 21:40:56 INFO - 2015-11-19 21:40:56,636 DEBUG : BROWSER_OUTPUT: |5;Earley;788.6435331230284 21:40:56 INFO - 2015-11-19 21:40:56,636 DEBUG : BROWSER_OUTPUT: |6;Boyer;12329.268292682927 21:40:56 INFO - 2015-11-19 21:40:56,636 DEBUG : BROWSER_OUTPUT: |7;RegExp;26526.315789473683 21:40:56 INFO - 2015-11-19 21:40:56,636 DEBUG : BROWSER_OUTPUT: |8;Splay;599.640933572711 21:40:56 INFO - 2015-11-19 21:40:56,637 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4854.368932038835 21:40:56 INFO - 2015-11-19 21:40:56,637 DEBUG : BROWSER_OUTPUT: __end_tp_report 21:40:56 INFO - 2015-11-19 21:40:56,637 DEBUG : BROWSER_OUTPUT: __startTimestamp1447998056633__endTimestamp 21:40:56 INFO - 2015-11-19 21:40:56,637 DEBUG : BROWSER_OUTPUT: 21:40:56 INFO - 2015-11-19 21:40:56,638 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 21:40:56 INFO - 2015-11-19 21:40:56,638 DEBUG : BROWSER_OUTPUT: Number of tests: 10 21:40:56 INFO - 2015-11-19 21:40:56,638 DEBUG : BROWSER_OUTPUT: 21:40:56 INFO - 2015-11-19 21:40:56,638 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:163.21 Median:163.21 stddev:0.00 (0.0%) 21:40:56 INFO - 2015-11-19 21:40:56,639 DEBUG : BROWSER_OUTPUT: Values: 163.2 21:40:56 INFO - 2015-11-19 21:40:56,639 DEBUG : BROWSER_OUTPUT: 21:40:56 INFO - 2015-11-19 21:40:56,639 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:193.91 Median:193.91 stddev:0.00 (0.0%) 21:40:56 INFO - 2015-11-19 21:40:56,639 DEBUG : BROWSER_OUTPUT: Values: 193.9 21:40:56 INFO - 2015-11-19 21:40:56,640 DEBUG : BROWSER_OUTPUT: 21:40:56 INFO - 2015-11-19 21:40:56,640 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:286.70 Median:286.70 stddev:0.00 (0.0%) 21:40:56 INFO - 2015-11-19 21:40:56,640 DEBUG : BROWSER_OUTPUT: Values: 286.7 21:40:56 INFO - 2015-11-19 21:40:56,641 DEBUG : BROWSER_OUTPUT: 21:40:56 INFO - 2015-11-19 21:40:56,641 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5025.13 Median:5025.13 stddev:0.00 (0.0%) 21:40:56 INFO - 2015-11-19 21:40:56,641 DEBUG : BROWSER_OUTPUT: Values: 5025.1 21:40:56 INFO - 2015-11-19 21:40:56,641 DEBUG : BROWSER_OUTPUT: 21:40:56 INFO - 2015-11-19 21:40:56,642 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1957.03 Median:1957.03 stddev:0.00 (0.0%) 21:40:56 INFO - 2015-11-19 21:40:56,642 DEBUG : BROWSER_OUTPUT: Values: 1957.0 21:40:56 INFO - 2015-11-19 21:40:56,642 DEBUG : BROWSER_OUTPUT: 21:40:56 INFO - 2015-11-19 21:40:56,643 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:788.64 Median:788.64 stddev:0.00 (0.0%) 21:40:56 INFO - 2015-11-19 21:40:56,643 DEBUG : BROWSER_OUTPUT: Values: 788.6 21:40:56 INFO - 2015-11-19 21:40:56,643 DEBUG : BROWSER_OUTPUT: 21:40:56 INFO - 2015-11-19 21:40:56,644 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12329.27 Median:12329.27 stddev:0.00 (0.0%) 21:40:56 INFO - 2015-11-19 21:40:56,644 DEBUG : BROWSER_OUTPUT: Values: 12329.3 21:40:56 INFO - 2015-11-19 21:40:56,644 DEBUG : BROWSER_OUTPUT: 21:40:56 INFO - 2015-11-19 21:40:56,644 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26526.32 Median:26526.32 stddev:0.00 (0.0%) 21:40:56 INFO - 2015-11-19 21:40:56,644 DEBUG : BROWSER_OUTPUT: Values: 26526.3 21:40:56 INFO - 2015-11-19 21:40:56,645 DEBUG : BROWSER_OUTPUT: 21:40:56 INFO - 2015-11-19 21:40:56,645 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:599.64 Median:599.64 stddev:0.00 (0.0%) 21:40:56 INFO - 2015-11-19 21:40:56,645 DEBUG : BROWSER_OUTPUT: Values: 599.6 21:40:56 INFO - 2015-11-19 21:40:56,646 DEBUG : BROWSER_OUTPUT: 21:40:56 INFO - 2015-11-19 21:40:56,646 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4854.37 Median:4854.37 stddev:0.00 (0.0%) 21:40:56 INFO - 2015-11-19 21:40:56,646 DEBUG : BROWSER_OUTPUT: Values: 4854.4 21:40:56 INFO - 2015-11-19 21:40:56,646 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 21:40:56 INFO - 2015-11-19 21:40:56,646 DEBUG : BROWSER_OUTPUT: 21:40:57 INFO - 2015-11-19 21:40:57,497 INFO : Browser exited with error code: 0 21:40:57 INFO - 2015-11-19 21:40:57,512 INFO : Completed test v8_7 (00:00:39) 21:40:57 INFO - 2015-11-19 21:40:57,652 INFO : Completed test suite (00:20:12) 21:40:57 INFO - 2015-11-19 21:40:57,652 DEBUG : Working with test: dromaeo_css 21:40:57 INFO - 2015-11-19 21:40:57,652 DEBUG : Generating results file: dromaeo_css 21:40:57 INFO - 2015-11-19 21:40:57,653 DEBUG : Working with test: kraken 21:40:57 INFO - 2015-11-19 21:40:57,653 DEBUG : Generating results file: kraken 21:40:57 INFO - 2015-11-19 21:40:57,654 INFO : javascript benchmark 21:40:57 INFO - 2015-11-19 21:40:57,654 DEBUG : Working with test: v8_7 21:40:57 INFO - 2015-11-19 21:40:57,654 DEBUG : Generating results file: v8_7 21:40:57 INFO - 2015-11-19 21:40:57,654 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 21:40:57 INFO - 2015-11-19 21:40:57,770 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,63,35]] 21:40:57 INFO - 2015-11-19 21:40:57,770 DEBUG : process_Request line: dromaeo_css 6920.86 graph.html#tests=[[72,63,35]] 21:40:57 INFO - 2015-11-19 21:40:57,770 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 21:40:57 INFO - 2015-11-19 21:40:57,868 DEBUG : process_Request line: kraken 1505.80 graph.html#tests=[[232,63,35]] 21:40:57 INFO - 2015-11-19 21:40:57,868 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 21:40:57 INFO - 2015-11-19 21:40:57,970 DEBUG : process_Request line: v8_7 19805.90 graph.html#tests=[[230,63,35]] 21:40:57 INFO - 2015-11-19 21:40:57,971 INFO : javascript benchmark 21:40:58 INFO - 2015-11-19 21:40:57,975 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3172.143521249263, 3288.227266592352, 3307.140143562673, 3316.005198440467, 3358.546596209512, 5293.9735301323435, 5468.453154684539, 5507.862303442416, 5516.448355164486, 5544.889102217953, 5435.83692489226, 5448.618596698233, 5492.368377636573, 5506.394296627368, 5561.193626924093, 4974.104661160981, 4992.775325110379, 5022.296878437021, 5029.1450453423, 5062.594992400599, 4947.77735001924, 5128.102582048145, 5145.76844042019, 5172.534471897528, 5211.140161873286, 4931.630127740434, 4983.825566105187, 5026.5727413169925, 5034.572061374751, 5049.596032317442, 4992.276119962621, 5057.393112826484, 5075.492450754932, 5095.0, 5110.310108135429, 4947.480514545993, 5043.445221025684, 5055.064813009568, 5065.544101030925, 5086.160783470723, 5335.839924802262, 5377.0321342158395, 5405.783768649249, 5420.0, 5433.049216387117, 5912.793052243151, 5923.674197919113, 5930.614510056876, 5936.940630593682, 5938.0499120141, 5693.089105743103, 5792.015357389254, 5910.763569457216, 5926.348101708809, 5936.821895343147, 5406.351237851483, 5514.283143191359, 5516.420775818561, 5518.144687573433, 5595.21666966625, 6004.219451471368, 6005.489533389711, 6018.127371531104, 6058.333583305921, 6114.602550834182, 5752.511036561856, 5808.332041815161, 5812.128180772918, 5812.912806307909, 5857.970710146422, 5810.709464526757, 5811.418858114239, 5918.319393269829, 5923.4076592340425, 5932.762689492372, 5863.0, 5868.383819698955, 5889.998700220973, 5926.0, 5956.6723830188885, 5821.388754180834, 5839.386864379264, 5856.0, 5857.88284234313, 5878.853028674232, 4399.186150562156, 4449.443819522559, 4527.0493196429115, 4530.252508336153, 4539.409876716072, 4045.5347635021762, 4073.4311818918895, 4087.509498860156, 4092.836286548564, 4095.0171958730284, 5657.6039677223025, 5686.3691314233465, 5687.943120568824, 5696.1455781633085, 5707.514861236758, 5719.971400142973, 5833.38749431312, 5836.387179346108, 5837.3870743571315, 6083.665398403042, 5583.441655834384, 5592.356878958891, 5632.845266720313, 5668.971655141698, 5671.943280567141, 5194.3247377840635, 5222.686638801684, 5235.188545775335, 5237.711925844115, 5239.44985776488, 5890.234269545017, 5954.702264886651, 6174.073888916699, 6182.1345011698395, 6208.81373558794, 5827.446392592697, 5892.970535147297, 5904.3210030847, 5954.225950626391, 5979.521638269015, 6056.031035034373, 6056.06131049688, 6076.058210977306, 6076.422739839708, 6195.566310358232, 5693.146028095819, 5780.104083867007, 5789.594728368974, 5804.883902322014, 5829.8251052468495, 5693.231413759089, 5757.222774925332, 5760.452756988079, 5766.452187042224, 5813.709314534341, 5869.853253668693, 5869.94130058711, 5875.50058245054, 5882.970585147047, 5897.085951677497, 5782.942170578241, 5835.037218858841, 5842.152887831326, 5852.239208902815, 5858.209141765978, 5430.5384042356845, 5503.449655034465, 5547.5007249347755, 5561.054620714407, 5663.716814159358, 5815.33123690764, 5857.326407463196, 5903.793367232126, 5949.8215053548465, 5963.552733545088, 5721.599488035964, 5750.971245143747, 5786.07422812348, 5788.363280039276, 5790.478856902899], "unit": "ms", "name": "dojo.html", "value": 5451.071289429052}, {"lowerIsBetter": false, "replicates": [578.3262499188446, 591.952643788497, 598.736555915397, 599.7720866070892, 611.0986295214557, 31283.843580782093, 32061.83969080157, 32070.839645801767, 32086.197845053855, 32143.678563214362, 40326.59673403265, 41217.175656486856, 41238.0, 41289.17421651573, 41322.7933860331, 8881.600327985256, 9053.50205738684, 9059.547022648874, 9059.682911098113, 9060.546972651375, 7815.218478152167, 8001.279884810366, 8005.559694216816, 8844.646214151426, 8958.596863141142, 10762.892371076307, 10990.615328463506, 10991.395473248967, 11013.83479247812, 11030.834537481944, 10510.579576816956, 10545.420001899893, 10582.470876456224, 10629.5216715248, 10640.201984851166, 7813.0, 7995.360371170351, 10378.221633377527, 10524.421156836372, 10608.734781630445, 39996.0, 40412.59587404118, 40434.797826010974, 40436.191276174315, 40467.79766101151, 3355.3457075870215, 3588.8731077008565, 3742.5321834770652, 3897.279003384383, 4082.9795851020854, 30485.542716859265, 30874.691253087407, 31272.843635781905, 31323.0, 31398.686013139806, 3938.2714197873483, 3969.543502497192, 3978.0, 4030.3016773079808, 4037.656799172074, 299586.0, 303235.0, 304659.0, 421409.0, 426038.0, 55846.441535584934, 56465.30604081884, 56490.435095648514, 56556.71721641366, 56557.434425656036, 61642.69178654078, 61846.0, 62093.068603970976, 62317.688411558556, 62355.68822155951, 14696.632584185481, 14893.18087505176, 14909.403623855142, 14983.775243371358, 15092.245387730569, 12082.0, 12233.816492752616, 12235.69410764738, 12245.08161887862, 12251.0, 20176.798232017787, 20381.49046273855, 20414.591708166052, 20452.488687782923, 20485.59028819415, 7495.550266983998, 7677.616119194018, 7692.538447693157, 7701.1143718473095, 7763.136847156755, 916.6562539047857, 957.7844984878486, 996.3324572536418, 1002.7042022603349, 1024.6618615856748, 29878.25304367408, 29913.700862991525, 29996.250093747833, 30077.548836767466, 30245.0, 1014.4978235773192, 1034.0900007992918, 1040.9115225205942, 1043.0, 1077.9245452818227, 15114.622134446507, 15329.540113796382, 15604.375824966874, 15612.687746245012, 15618.297176626851, 320451.0, 323753.0, 325198.0, 327554.0, 327952.0, 54001.72999134979, 54263.18605220846, 54319.0, 54419.0, 54424.0, 1332.4670131947298, 1344.6638340414897, 1363.4886917405972, 1364.9658758530918, 1368.9178649281075, 28701.569476458288, 29303.560446592892, 30125.698743013167, 30334.0, 31233.375332492767, 47453.0, 47881.52118478771, 47889.760551198415, 47893.28160077532, 47927.0, 273821.0, 278919.0, 294816.0, 299081.0, 299840.0, 30779.0, 30813.845930770203, 30991.380172396875, 31056.378872422876, 31144.0, 44118.33822492729, 45226.32160517661, 45291.0, 45889.311660324456, 46244.76877615591, 37476.625233748404, 37830.62169378271, 38453.230935380576, 38934.41598376083, 39210.60789392069, 36175.27649447049, 36916.446253306756, 37616.24767504689, 38708.6129138705, 38859.80570097244, 33316.33367332688, 33419.66580334165, 36483.0, 37144.628553714116, 37233.0, 28998.855005724836, 32214.516782247818, 32329.51505727463, 32409.51385729263, 32591.674083258862, 24678.74006335579, 24801.511909285502, 24928.62607060932, 25044.12345567969, 25376.365590860376], "unit": "ms", "name": "ext.html", "value": 19021.821742513555}, {"lowerIsBetter": false, "replicates": [355.34793653645556, 357.297909607621, 357.6030606027311, 357.64235764235747, 358.91386067343836, 13741.450341986309, 14146.0, 16160.515184544467, 16384.67230655386, 17073.231704573293, 14616.707665846676, 15943.282552285145, 15957.281922313494, 15984.920075399636, 16944.491665250032, 5352.785888564453, 5509.090999985017, 5510.201020851974, 5513.338399392059, 5515.448455154493, 3995.8201880915285, 4063.2686116499017, 5442.156465747816, 5480.150576660604, 5893.263342082239, 5951.613145145551, 5978.342382337939, 6004.0, 6007.609505382136, 6008.369121242272, 5028.823991160292, 5160.251763494272, 5162.793488260465, 5163.044836705203, 5958.9702051489685, 4919.385076865392, 4960.082384758831, 4960.206366981266, 4981.277714731344, 5067.543921047123, 12221.205621634654, 12316.076294277966, 12403.813942790865, 15621.687566248725, 19816.30642927505, 2053.537953960362, 2066.442060643633, 2072.3990042887544, 2098.5068508900395, 2202.031106313217, 8973.865392019125, 9766.365186262941, 12193.902548770653, 12334.629961101182, 12619.684507887285, 1759.7448369986407, 1783.2153852304943, 1786.1337251433044, 1821.307902996866, 1847.575057736728, 59435.0, 61418.38581614216, 62432.37567624311, 62701.37298627001, 62746.0, 9714.805703885882, 9957.601695932082, 9965.850512242323, 9980.255429756875, 10039.498025098716, 13204.801927971088, 13232.470701172038, 13275.468981240836, 13276.933615331862, 13281.601551953458, 7114.501984861114, 7145.857082858313, 7364.889526656997, 7469.663865126083, 7489.101307842985, 6462.095306657072, 6481.351864813481, 6503.349665033554, 6523.282438931714, 6546.639934803537, 4080.0819815541267, 4089.7137200395687, 4098.672106231495, 4189.937150942738, 4245.172191422643, 1621.60270733671, 1691.7124088904916, 1697.244726096875, 2743.2593199835933, 2843.4170994945985, 833.5540485840046, 908.7864351877304, 921.235374639048, 937.7280588629358, 1076.6769969009265, 16590.17049147538, 17051.403200887908, 17389.82610173882, 17409.303627854744, 17522.737158942626, 436.8990144834998, 437.2435686262783, 448.9012417268196, 919.4942781470164, 1018.872640919885, 5461.0, 5817.50551203144, 5840.065589505659, 5893.764249430061, 5935.703214839241, 358006.0, 364857.0, 407694.0, 527807.0, 531869.0, 79623.0, 83296.0, 84638.0, 84671.0, 84696.0, 471.69811320754746, 485.09529727059487, 485.95383438573276, 486.0061174897343, 486.5912633387971, 9993.850092248767, 10016.048475394826, 10035.54840032215, 10071.798564028531, 10132.0, 34091.48862767011, 34943.475847861795, 35355.64644353523, 35474.0, 35966.280674386886, 46027.07945840997, 46321.76839115783, 47308.52691473041, 47487.0, 47570.0, 9417.764555886157, 9445.29160312993, 9455.574499147417, 9626.181774549243, 9634.566444509874, 17044.14779261007, 17105.914470427568, 17159.31362745476, 17308.394206202724, 17952.640947181244, 13799.448022079005, 14775.704485910437, 14854.628634284229, 14869.776953345925, 15012.324445400202, 14543.85456145425, 14637.341319640429, 14777.261136942894, 14808.481703140338, 15294.464693735667, 14467.27663616836, 14890.925545372203, 15092.773608395662, 15179.544613661608, 15701.0, 9400.0, 9435.716928492157, 9581.137697607248, 9610.231181505602, 9636.614535418505, 2803.3412148145576, 11338.670824712372, 13024.218546887218, 14607.634809129857, 14892.0], "unit": "ms", "name": "jquery.html", "value": 8208.653616515703}, {"lowerIsBetter": false, "replicates": [1309.0967232609505, 1638.6804573108243, 1698.150924537731, 1716.545115544381, 1728.3777839977606, 6463.418292353687, 7445.255474452552, 7596.126445458767, 7599.430042746802, 7600.5439673619485, 7401.0, 7514.887276690841, 7517.661705223264, 7528.58592777397, 7528.623568821551, 2170.5007848194923, 2188.9014994325294, 2193.74771901231, 2197.703310053146, 2197.846150769447, 2231.866088034723, 2239.7760223977634, 2244.5286489837154, 2255.1768604459335, 2265.2411442166813, 2160.7083043789044, 2187.912483500666, 2190.5728382965326, 2192.7697591752876, 2193.1775584155944, 2169.7830216978255, 2175.9555413401654, 2176.227439259056, 2178.4662757624483, 2178.6296329624, 2236.9217077402213, 2283.4633861042644, 2285.0973865323103, 2285.371522831218, 2286.7713228677167, 6557.967210163966, 6762.0, 7482.102147742251, 7524.209957954446, 7539.170691223961, 4427.358033085216, 4550.703049630839, 4553.954460455386, 4559.863204103882, 4565.223911934979, 3054.053243494524, 3069.3400918802563, 3097.3650401667605, 3104.6584875663657, 3211.0527394418705, 1090.9127269818396, 1116.4083035990939, 1136.7044568412189, 1141.6403832792644, 1144.525022115821, 10344.5344959477, 10613.681589552325, 10632.734181645521, 10634.787304253949, 10637.255392122555, 4057.330540460791, 4097.180563887175, 4136.875893723193, 4137.234611596864, 4142.647874930604, 8617.827643447095, 8638.611262493203, 8640.870386944202, 8644.697435589724, 8649.740507784776, 4609.907801844011, 4624.190766615829, 4635.884102897455, 4637.1421287062, 4638.489766125724, 4257.808398622069, 4264.1471705659, 4269.316909294498, 4273.67947403946, 4275.315949448073, 3429.3484237994703, 3437.0, 3440.82795860206, 3447.258839349552, 3464.411050121435, 1038.2109596706557, 1051.9263651544472, 1054.6045233037612, 1057.471264367816, 1060.261171678448, 1286.6075846866795, 1296.403654319005, 1310.9344532773323, 1340.9664758380923, 1341.3427420563853, 7239.384652304508, 7250.891236631454, 7317.780466586011, 7319.0, 7348.2284360142485, 458.6147635985788, 469.48825779900073, 481.68208982072366, 482.6114977443192, 483.59136529632406, 5084.923726144111, 5408.567314614821, 5454.536364409069, 5458.5087342139395, 5473.698946557977, 8271.462354947029, 9028.277737781093, 9163.31275154366, 9278.0, 9278.62885484573, 8884.555772211364, 9040.367174297737, 9049.502277374675, 9121.224695900923, 9164.95417522908, 7089.149302083783, 7160.10498687664, 7181.0, 7186.928130718626, 7206.207317195104, 6957.965210173917, 6998.090248267693, 7011.509194356346, 7045.1898031727005, 7067.187273463617, 7854.096778870275, 7876.684932602631, 8061.556614386265, 8092.83814323722, 8097.190280971856, 8041.195880411912, 8142.0, 8154.673813047411, 8259.504429734236, 8290.502569845828, 7034.155901291878, 7122.893156602759, 7135.928640713526, 7141.64291785419, 7146.392556632744, 7245.818854528679, 7390.1131864174495, 7393.519421237603, 7423.517471364344, 7433.665485053294, 6766.0, 6773.932260677528, 6812.386885180357, 6817.079694241214, 6849.589024658537, 6829.897551536632, 6953.965230174019, 6958.617276049866, 7027.61348125858, 7062.117235345582, 6870.7595234166565, 6961.686724097326, 6978.720851165896, 6982.231954484901, 6995.79012629622, 6425.742970281136, 6442.677866106582, 6448.355164483514, 6466.773662921775, 6470.708818103102, 6126.479249263684, 6241.157443745036, 6242.750289988349, 6257.2804127525915, 6440.742370305135], "unit": "ms", "name": "mootools.html", "value": 4305.616066755038}, {"lowerIsBetter": false, "replicates": [318.361684821932, 323.88340197528885, 325.4597368368509, 328.83722557334124, 336.07076433660933, 5975.312839023519, 5979.1629171915965, 5991.730372133254, 6037.577369584131, 6073.1497590337385, 5705.343885453174, 5796.62321949073, 5847.327557330908, 5924.229850119489, 5956.5234781217505, 4558.225101732697, 4580.083983203373, 4582.0, 4582.633389328862, 4595.126925884079, 4407.603315701586, 4583.793729282191, 4593.356930029799, 4595.678302518825, 4596.310553416981, 4429.379886815848, 4491.483479399862, 4520.11857687751, 4532.864014079583, 4538.6369090472845, 4444.644428445717, 4494.662900282492, 4507.932381014288, 4511.142882852264, 4512.278035514302, 3987.4218238355566, 4008.178323443716, 4010.8796736097966, 4013.618706222904, 4014.3376342903384, 5478.260434841325, 5653.575981801381, 5662.150677398423, 5664.575156863251, 5668.546516278688, 5287.841364759025, 5301.257823904618, 5318.547923426513, 5318.680879147263, 5322.654027488201, 6342.39747224013, 6342.556021078526, 6343.8731225375695, 6347.777827776005, 6350.745970161188, 4460.576245256695, 4463.419755431805, 4465.352523884018, 4465.9106817863785, 4477.48508921475, 6417.326180751001, 6586.04502347157, 6586.967065164691, 6589.901151482732, 6597.571157874723, 4446.777661116931, 4481.103779244099, 4481.327800829901, 4483.574060464251, 4486.708363956398, 4537.274036154199, 4537.636989040869, 4538.88652783683, 4542.295944128599, 4543.159515489645, 5263.6315457918345, 5264.499872512105, 5264.684118952875, 5272.05103081449, 5276.182191760283, 6253.468455181361, 6386.712597933104, 6388.8083357499345, 6400.295967443578, 6408.166938297992, 1579.778830963666, 1592.944246951351, 1597.2013993003497, 1598.7601859720903, 1599.072537927999, 1042.6871938418597, 1049.994750026245, 1059.5391004912888, 1067.8558394616782, 1068.71144790906, 6204.751809927642, 6207.96896015517, 6212.9068063979075, 6214.937850621436, 6216.906746398808, 6589.835254118685, 6592.24189218246, 6593.703283352261, 6605.07528945948, 6619.5035372347265, 6030.849228769228, 6131.325554189036, 6183.3816618337805, 6276.246850377984, 6295.811125666238, 3568.3398571264397, 3578.5526809148855, 3586.228960773446, 3594.658507441789, 3595.7303202259936, 6843.863122737517, 6857.725690972405, 6861.1080559526945, 6862.0, 6868.793936181923, 6602.0, 6789.0, 6800.727970881208, 6809.591424514545, 6810.6254156020905, 6819.079424277659, 6819.113515243086, 6830.146231721035, 6830.487713421513, 6838.042674025641, 6620.933790662032, 6627.271000189879, 6627.641333526712, 6630.7679231226675, 6632.336766323329, 6393.232812062396, 6597.60414375139, 6617.536772426077, 6618.63597502142, 6620.304867988792, 6837.453003759588, 6893.827654308482, 6894.0, 6897.068895699016, 6904.620245886525, 4467.642588592969, 4492.9775351123035, 4495.595396414338, 4499.167653984024, 4514.864554063383, 6493.707783149675, 6584.04531342943, 6647.335266473314, 6658.400743933069, 6661.0, 6458.644774537258, 6463.86882295587, 6466.094746735367, 6467.935320646733, 6469.708863101077, 6399.616023038632, 6447.2263328400895, 6449.548531602931, 6452.419282264619, 6466.06242094903, 6137.84655383619, 6330.715117819617, 6343.302236754045, 6344.841378965562, 6360.713767880364, 6467.482601391972, 6473.2232132144445, 6479.060536222127, 6479.935200648122, 6499.512536559682, 6187.690615469299, 6334.936650633619, 6348.746050157942, 6348.936510634834, 6352.555321127476], "unit": "ms", "name": "prototype.html", "value": 4802.77342433624}, {"lowerIsBetter": false, "replicates": [808.5916612110883, 822.2846123872232, 822.6154596003307, 836.1011912194392, 854.0, 13020.869791302084, 13302.334883255835, 13322.267275299855, 13330.133541319807, 13337.933310333447, 12532.874671253285, 12622.68443288916, 12624.305663188521, 12643.367831608406, 12646.494140234403, 677.0183234310246, 682.604089628017, 805.6133056133074, 809.34038758412, 823.8187598728271, 820.9753707388788, 820.983580328393, 829.7178959153887, 829.7759604906671, 830.3772170871846, 700.5761514283836, 861.28513333933, 867.9218870301671, 868.4702331577732, 868.6525389844081, 709.5033476566424, 844.5481667307992, 866.3372520022189, 868.6481974800216, 869.8695195720693, 619.6406084470996, 620.8696173803506, 626.3892704613012, 626.683524819963, 627.9058141278845, 12735.936320318431, 12854.228746275254, 12957.222566645936, 12988.935055324662, 12992.740145197044, 11543.249688770204, 11579.421028948518, 11882.881171188264, 12411.0, 12427.254364738144, 10129.290949633529, 10351.792964140675, 10413.635522756667, 10481.371117732884, 10492.632757853515, 3648.2703459308245, 3703.407454807245, 3720.1629633332554, 3720.7395482316247, 3730.5896351401325, 42838.143237135395, 43271.567284327386, 43321.35017974733, 43383.52931765451, 43472.565274347166, 10051.748706282255, 10116.898831011596, 10147.441890696082, 10368.688939331832, 10382.948085259677, 17722.556936076442, 17755.46733597994, 17769.11154442273, 18464.169112389976, 18503.81496185048, 7566.508176968479, 7617.809554761176, 7904.6838126474295, 7909.05091389037, 7937.761867143995, 3961.7028722845903, 3967.1668949520345, 3976.741511801724, 4042.413849991735, 4076.0421300994244, 2987.731104200632, 3037.271054946841, 3043.8630261638277, 3044.1476386611785, 3048.5122380419025, 555.4084899581933, 558.0206737176311, 561.7022977821761, 566.2157911292807, 575.5999580291657, 640.1869625575494, 664.1797380235405, 670.4267850987433, 672.314239475732, 688.5111570784699, 8831.779205519913, 8876.0, 8899.421537600036, 8918.821623567492, 8929.196372326393, 635.1203583037526, 667.9098321726602, 671.7615246587488, 679.4734081087197, 697.7906628011576, 3923.9925826969566, 4087.570805065485, 4097.078157414558, 4248.681348898845, 4559.726416415026, 54696.0, 54940.72529637326, 54961.450385495635, 55028.72485637546, 56940.14589781156, 46481.30278045832, 46525.0, 49029.26456103161, 51436.74281628643, 51505.48494515082, 46081.7695911525, 46276.0, 47129.764351178026, 47231.0, 47297.763511182915, 8713.956430217808, 8754.91245087541, 8982.550872456482, 9056.184943355129, 9176.908230917872, 32708.672913271515, 32917.67082329146, 33558.66441335653, 33572.0, 33948.64205431854, 40075.599244007186, 40360.59639403568, 40411.1917761649, 41461.37807932823, 41871.7906410466, 10336.844947325946, 10466.215033872339, 10754.354738715701, 10825.404602746925, 10974.341539507655, 11716.179867409199, 12138.696532586757, 12172.147949643795, 12179.330136842558, 12455.93772031134, 10825.512851921525, 11201.948164898438, 11259.943700281447, 11375.31748095117, 11720.589779357682, 10876.238663293494, 11181.32912025281, 11264.549418023187, 11488.885111149117, 11565.710857228636, 10975.780484390109, 10989.285696429706, 11026.944865275622, 11362.261453005529, 11364.715882103013, 9556.85238896357, 9900.257480688833, 9905.950470247602, 9930.106290433896, 10210.642627508001, 9064.320175986695, 9152.633894644407, 9715.22278217755, 10089.89910100919, 10124.949375253076], "unit": "ms", "name": "yui.html", "value": 6242.922436634996}], "name": "dromaeo_css", "value": 6920.861599709138}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 111.0, 102.0, 111.0, 111.0, 112.0, 100.0, 110.0, 110.0, 110.0], "unit": "ms", "name": "ai-astar", "value": 108.7}, {"lowerIsBetter": true, "replicates": [161.0, 126.0, 154.0, 166.0, 126.0, 151.0, 160.0, 125.0, 166.0, 125.0], "unit": "ms", "name": "audio-beat-detection", "value": 146.0}, {"lowerIsBetter": true, "replicates": [161.0, 159.0, 160.0, 159.0, 158.0, 160.0, 160.0, 162.0, 161.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 160.1}, {"lowerIsBetter": true, "replicates": [71.0, 73.0, 93.0, 99.0, 72.0, 72.0, 72.0, 97.0, 90.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 81.1}, {"lowerIsBetter": true, "replicates": [90.0, 90.0, 134.0, 90.0, 91.0, 91.0, 136.0, 91.0, 90.0, 137.0], "unit": "ms", "name": "audio-oscillator", "value": 104.0}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 109.0, 109.0, 110.0, 109.0, 109.0, 110.0, 110.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 145.0, 144.0, 144.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.3}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 97.0, 96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [68.0, 65.0, 64.0, 65.0, 64.0, 66.0, 65.0, 71.0, 63.0, 66.0], "unit": "ms", "name": "json-parse-financial", "value": 65.7}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 68.0, 68.0, 69.0, 77.0, 69.0, 69.0, 70.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.4}, {"lowerIsBetter": true, "replicates": [85.0, 83.0, 92.0, 84.0, 86.0, 84.0, 84.0, 86.0, 86.0, 84.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.4}, {"lowerIsBetter": true, "replicates": [123.0, 122.0, 116.0, 116.0, 122.0, 121.0, 125.0, 113.0, 117.0, 133.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 120.8}, {"lowerIsBetter": true, "replicates": [142.0, 142.0, 155.0, 150.0, 154.0, 142.0, 152.0, 149.0, 148.0, 143.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 147.7}, {"lowerIsBetter": true, "replicates": [67.0, 66.0, 66.0, 67.0, 67.0, 67.0, 65.0, 67.0, 66.0, 67.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 66.5}], "name": "kraken", "value": 1505.8000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [163.21201240411295], "unit": "score", "name": "Richards", "value": 216.29535399999995}, {"lowerIsBetter": false, "replicates": [193.91118867558657], "unit": "score", "name": "DeltaBlue", "value": 340.97052599999995}, {"lowerIsBetter": false, "replicates": [286.697247706422], "unit": "score", "name": "Encrypt", "value": 928.4393279999997}, {"lowerIsBetter": false, "replicates": [5025.125628140703], "unit": "score", "name": "Decrypt", "value": 52.970019}, {"lowerIsBetter": false, "replicates": [1957.03125], "unit": "score", "name": "RayTrace", "value": 378.11813173652706}, {"lowerIsBetter": false, "replicates": [788.6435331230284], "unit": "score", "name": "Earley", "value": 845.075084}, {"lowerIsBetter": false, "replicates": [12329.268292682927], "unit": "score", "name": "Boyer", "value": 54.05535707220569}, {"lowerIsBetter": false, "replicates": [26526.315789473683], "unit": "score", "name": "RegExp", "value": 34.34268849206351}, {"lowerIsBetter": false, "replicates": [599.640933572711], "unit": "score", "name": "Splay", "value": 135.89966167664664}, {"lowerIsBetter": false, "replicates": [4854.368932038835], "unit": "score", "name": "NavierStokes", "value": 305.7040000000001}], "name": "v8_7", "value": 19805.895397885768}]} 21:40:58 INFO - RETURN: dromaeo_css: 6920.86 21:40:58 INFO - RETURN: kraken: 1505.80 21:40:58 INFO - RETURN: v8_7: 19805.90 21:40:58 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,35]]", "result": "19805.90"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,35]]", "result": "1505.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,35]]", "result": "6920.86"}}} 21:40:58 INFO - Return code: 0 21:40:58 INFO - # TBPL SUCCESS # 21:40:58 INFO - Running post-action listener: _resource_record_post_action 21:40:58 INFO - Running post-run listener: _resource_record_post_run 21:40:59 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 0; Write bytes: 496664576; Read time: 0; Write time: 523320 21:40:59 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 234422272; Read time: 0; Write time: 367772 21:40:59 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 0; Write bytes: 262242304; Read time: 0; Write time: 155548 21:40:59 INFO - Running post-run listener: _upload_blobber_files 21:40:59 INFO - Blob upload gear active. 21:40:59 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 21:40:59 INFO - Copying logs to upload dir... 21:40:59 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1282.349360 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2015-11-19 21:40:58.823124) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-19 21:40:58.826411) ========= 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=447a3abc0420b6a47dd38cba000001bf-1447996238.572703-268325781 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/-aDrMBVKT8Ss3r1ume4yzw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010162 build_url: 'https://queue.taskcluster.net/v1/task/-aDrMBVKT8Ss3r1ume4yzw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-19 21:40:58.877005) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 21:40:58.877334) ========= 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=447a3abc0420b6a47dd38cba000001bf-1447996238.572703-268325781 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004558 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 21:40:58.926860) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-19 21:40:58.927186) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-19 21:40:58.927465) ========= ========= Total master_lag: 0.25 =========