builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-043 starttime: 1451450371.82 results: success (0) buildid: 20151229183039 builduid: 713187db5589452499c9c0b9d4605286 revision: bc679c4aeb59 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-29 20:39:31.822256) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-29 20:39:31.822838) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-29 20:39:31.823157) ========= 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=ae8083fbfc14dfa356ee9053000001f7-1451448626.518699-1847082600 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006280 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-29 20:39:31.852826) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-29 20:39:31.853138) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-29 20:39:31.870730) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 20:39:31.871146) ========= 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=ae8083fbfc14dfa356ee9053000001f7-1451448626.518699-1847082600 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004518 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 20:39:31.922038) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-29 20:39:31.922362) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-29 20:39:31.922815) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 20:39:31.923125) ========= 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=ae8083fbfc14dfa356ee9053000001f7-1451448626.518699-1847082600 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-29 20:39:32-- 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% 222M=0s 2015-12-29 20:39:32 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.165960 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 20:39:32.101033) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 20:39:32.101336) ========= 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=ae8083fbfc14dfa356ee9053000001f7-1451448626.518699-1847082600 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015508 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 20:39:32.152244) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 20:39:32.152647) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev bc679c4aeb59 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev bc679c4aeb59 --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=ae8083fbfc14dfa356ee9053000001f7-1451448626.518699-1847082600 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-29 20:39:32,803 Setting DEBUG logging. 2015-12-29 20:39:32,803 attempt 1/10 2015-12-29 20:39:32,803 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/bc679c4aeb59?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-29 20:39:33,039 unpacking tar archive at: mozilla-beta-bc679c4aeb59/testing/mozharness/ program finished with exit code 0 elapsedTime=0.529774 ========= master_lag: 0.40 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 20:39:33.085547) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-29 20:39:33.085848) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-29 20:39:33.111387) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-29 20:39:33.111849) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-29 20:39:33.112586) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2015-12-29 20:39:33.113092) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=ae8083fbfc14dfa356ee9053000001f7-1451448626.518699-1847082600 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:39:33 INFO - MultiFileLogger online at 20151229 20:39:33 in /builds/slave/test-pgo 20:39:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 20:39:33 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 20:39:33 INFO - {'append_to_log': False, 20:39:33 INFO - 'base_work_dir': '/builds/slave/test-pgo', 20:39:33 INFO - 'blob_upload_branch': 'Mozilla-Beta', 20:39:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 20:39:33 INFO - 'branch': 'Mozilla-Beta', 20:39:33 INFO - 'buildbot_json_path': 'buildprops.json', 20:39:33 INFO - 'config_files': ('talos/linux_config.py',), 20:39:33 INFO - 'default_actions': ('clobber', 20:39:33 INFO - 'read-buildbot-config', 20:39:33 INFO - 'download-and-extract', 20:39:33 INFO - 'populate-webroot', 20:39:33 INFO - 'create-virtualenv', 20:39:33 INFO - 'install', 20:39:33 INFO - 'run-tests'), 20:39:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:39:33 INFO - 'download_minidump_stackwalk': True, 20:39:33 INFO - 'download_symbols': 'ondemand', 20:39:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:39:33 INFO - 'tooltool.py': '/tools/tooltool.py', 20:39:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:39:33 INFO - '/tools/misc-python/virtualenv.py')}, 20:39:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:39:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:39:33 INFO - 'installer_path': 'installer.exe', 20:39:33 INFO - 'log_level': 'info', 20:39:33 INFO - 'log_name': 'talos', 20:39:33 INFO - 'log_to_console': True, 20:39:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:39:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:39:33 INFO - 'opt_config_files': (), 20:39:33 INFO - 'pip_index': False, 20:39:33 INFO - 'sps_profile': False, 20:39:33 INFO - 'sps_profile_interval': 0, 20:39:33 INFO - 'suite': 'dromaeojs', 20:39:33 INFO - 'system_bits': '32', 20:39:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:39:33 INFO - 'title': 'talos-linux64-ix-043', 20:39:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:39:33 INFO - 'use_talos_json': True, 20:39:33 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 20:39:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:39:33 INFO - 'work_dir': 'build'} 20:39:33 INFO - ##### 20:39:33 INFO - ##### Running clobber step. 20:39:33 INFO - ##### 20:39:33 INFO - Running pre-action listener: _resource_record_pre_action 20:39:33 INFO - Running main action method: clobber 20:39:33 INFO - rmtree: /builds/slave/test-pgo/build 20:39:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 20:39:34 INFO - Running post-action listener: _resource_record_post_action 20:39:34 INFO - ##### 20:39:34 INFO - ##### Running read-buildbot-config step. 20:39:34 INFO - ##### 20:39:34 INFO - Running pre-action listener: _resource_record_pre_action 20:39:34 INFO - Running main action method: read_buildbot_config 20:39:34 INFO - Using buildbot properties: 20:39:34 INFO - { 20:39:34 INFO - "properties": { 20:39:34 INFO - "buildnumber": 53, 20:39:34 INFO - "product": "firefox", 20:39:34 INFO - "script_repo_revision": "production", 20:39:34 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 20:39:34 INFO - "repository": "", 20:39:34 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 20:39:34 INFO - "buildid": "20151229183039", 20:39:34 INFO - "slavename": "talos-linux64-ix-043", 20:39:34 INFO - "pgo_build": "True", 20:39:34 INFO - "basedir": "/builds/slave/test-pgo", 20:39:34 INFO - "project": "", 20:39:34 INFO - "platform": "ubuntu64_hw", 20:39:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 20:39:34 INFO - "slavebuilddir": "test", 20:39:34 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 20:39:34 INFO - "branch": "mozilla-beta", 20:39:34 INFO - "repo_path": "releases/mozilla-beta", 20:39:34 INFO - "stage_platform": "linux64-pgo", 20:39:34 INFO - "builduid": "713187db5589452499c9c0b9d4605286", 20:39:34 INFO - "revision": "bc679c4aeb59" 20:39:34 INFO - }, 20:39:34 INFO - "sourcestamp": { 20:39:34 INFO - "repository": "", 20:39:34 INFO - "hasPatch": false, 20:39:34 INFO - "project": "", 20:39:34 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 20:39:34 INFO - "changes": [ 20:39:34 INFO - { 20:39:34 INFO - "category": null, 20:39:34 INFO - "files": [ 20:39:34 INFO - { 20:39:34 INFO - "url": null, 20:39:34 INFO - "name": "http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1451442639/firefox-44.0.en-US.linux-x86_64.tar.bz2" 20:39:34 INFO - } 20:39:34 INFO - ], 20:39:34 INFO - "repository": "", 20:39:34 INFO - "rev": "bc679c4aeb59", 20:39:34 INFO - "who": "sendchange", 20:39:34 INFO - "when": 1451450308, 20:39:34 INFO - "number": 7401637, 20:39:34 INFO - "comments": "Bug 1233346: r=ekr a=abillings", 20:39:34 INFO - "project": "", 20:39:34 INFO - "at": "Tue 29 Dec 2015 20:38:28", 20:39:34 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 20:39:34 INFO - "revlink": "", 20:39:34 INFO - "properties": [ 20:39:34 INFO - [ 20:39:34 INFO - "buildid", 20:39:34 INFO - "20151229183039", 20:39:34 INFO - "Change" 20:39:34 INFO - ], 20:39:34 INFO - [ 20:39:34 INFO - "builduid", 20:39:34 INFO - "713187db5589452499c9c0b9d4605286", 20:39:34 INFO - "Change" 20:39:34 INFO - ], 20:39:34 INFO - [ 20:39:34 INFO - "pgo_build", 20:39:34 INFO - "True", 20:39:34 INFO - "Change" 20:39:34 INFO - ] 20:39:34 INFO - ], 20:39:34 INFO - "revision": "bc679c4aeb59" 20:39:34 INFO - } 20:39:34 INFO - ], 20:39:34 INFO - "revision": "bc679c4aeb59" 20:39:34 INFO - } 20:39:34 INFO - } 20:39:34 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1451442639/firefox-44.0.en-US.linux-x86_64.tar.bz2. 20:39:34 INFO - Running post-action listener: _resource_record_post_action 20:39:34 INFO - ##### 20:39:34 INFO - ##### Running download-and-extract step. 20:39:34 INFO - ##### 20:39:34 INFO - Running pre-action listener: _resource_record_pre_action 20:39:34 INFO - Running main action method: download_and_extract 20:39:34 INFO - mkdir: /builds/slave/test-pgo/build/tests 20:39:34 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')]} 20:39:34 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1451442639/test_packages.json 20:39:34 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1451442639/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 20:39:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1451442639/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 20:39:34 INFO - Downloaded 1270 bytes. 20:39:34 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 20:39:34 INFO - Using the following test package requirements: 20:39:34 INFO - {u'common': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip'], 20:39:34 INFO - u'cppunittest': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 20:39:34 INFO - u'firefox-44.0.en-US.linux-x86_64.cppunittest.tests.zip'], 20:39:34 INFO - u'jittest': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 20:39:34 INFO - u'jsshell-linux-x86_64.zip'], 20:39:34 INFO - u'mochitest': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 20:39:34 INFO - u'firefox-44.0.en-US.linux-x86_64.mochitest.tests.zip'], 20:39:34 INFO - u'mozbase': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip'], 20:39:34 INFO - u'reftest': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 20:39:34 INFO - u'firefox-44.0.en-US.linux-x86_64.reftest.tests.zip'], 20:39:34 INFO - u'talos': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 20:39:34 INFO - u'firefox-44.0.en-US.linux-x86_64.talos.tests.zip'], 20:39:34 INFO - u'web-platform': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 20:39:34 INFO - u'firefox-44.0.en-US.linux-x86_64.web-platform.tests.zip'], 20:39:34 INFO - u'webapprt': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip'], 20:39:34 INFO - u'xpcshell': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 20:39:34 INFO - u'firefox-44.0.en-US.linux-x86_64.xpcshell.tests.zip']} 20:39:34 INFO - Downloading packages: [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:39:34 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')]} 20:39:34 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1451442639/firefox-44.0.en-US.linux-x86_64.common.tests.zip 20:39:34 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1451442639/firefox-44.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip 20:39:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1451442639/firefox-44.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:39:37 INFO - Downloaded 22571521 bytes. 20:39:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 20:39:37 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip 20:39:37 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 20:39:38 INFO - Return code: 0 20:39:38 INFO - Downloading packages: [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', u'firefox-44.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 20:39:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:39:38 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1451442639/firefox-44.0.en-US.linux-x86_64.common.tests.zip 20:39:38 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1451442639/firefox-44.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip 20:39:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1451442639/firefox-44.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:39:39 INFO - Downloaded 22571521 bytes. 20:39:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 20:39:39 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip 20:39:39 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 20:39:40 INFO - Return code: 0 20:39:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:39:40 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1451442639/firefox-44.0.en-US.linux-x86_64.talos.tests.zip 20:39:40 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1451442639/firefox-44.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.talos.tests.zip 20:39:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1451442639/firefox-44.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 20:39:43 INFO - Downloaded 11131970 bytes. 20:39:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 20:39:43 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.talos.tests.zip 20:39:43 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 20:39:43 INFO - Return code: 0 20:39: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')]} 20:39:43 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1451442639/firefox-44.0.en-US.linux-x86_64.tar.bz2 20:39:43 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1451442639/firefox-44.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.tar.bz2 20:39:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1451442639/firefox-44.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 20:39:51 INFO - Downloaded 56619583 bytes. 20:39:51 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1451442639/firefox-44.0.en-US.linux-x86_64.tar.bz2 20:39:51 INFO - mkdir: /builds/slave/test-pgo/properties 20:39:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 20:39:51 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 20:39:51 INFO - Contents: 20:39:51 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1451442639/firefox-44.0.en-US.linux-x86_64.tar.bz2 20:39:51 INFO - Running post-action listener: _resource_record_post_action 20:39:51 INFO - Running post-action listener: set_extra_try_arguments 20:39:51 INFO - ##### 20:39:51 INFO - ##### Running populate-webroot step. 20:39:51 INFO - ##### 20:39:51 INFO - Running pre-action listener: _resource_record_pre_action 20:39:51 INFO - Running main action method: populate_webroot 20:39:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:39:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:39:51 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 20:39:51 INFO - '../fennec_ids.txt'], 20:39:51 INFO - 'tests': ['tcheck2']}, 20:39:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:39:51 INFO - '--tppagecycles', 20:39:51 INFO - '7'], 20:39:51 INFO - 'tests': ['tsvgm']}}, 20:39:51 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 20:39:51 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 20:39:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:39:51 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 20:39:51 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 20:39:51 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 20:39:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:39:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:39:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:39:51 INFO - 'talos_options': ['--e10s'], 20:39:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:39:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:39:51 INFO - 'tests': ['damp', 'tps']}, 20:39:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:39:51 INFO - 'talos_options': ['--e10s'], 20:39:51 INFO - 'tests': ['damp', 'tps']}, 20:39:51 INFO - 'g3': {'tests': ['dromaeo_dom']}, 20:39:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:39:51 INFO - 'other': {'tests': ['a11yr', 20:39:51 INFO - 'ts_paint', 20:39:51 INFO - 'tpaint', 20:39:51 INFO - 'sessionrestore', 20:39:51 INFO - 'sessionrestore_no_auto_restore']}, 20:39:51 INFO - 'other-e10s': {'talos_options': ['--e10s'], 20:39:51 INFO - 'tests': ['a11yr', 20:39:51 INFO - 'ts_paint', 20:39:51 INFO - 'tpaint', 20:39:51 INFO - 'sessionrestore', 20:39:51 INFO - 'sessionrestore_no_auto_restore']}, 20:39:51 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 20:39:51 INFO - 'tests': ['a11yr', 20:39:51 INFO - 'ts_paint', 20:39:51 INFO - 'tpaint', 20:39:51 INFO - 'sessionrestore', 20:39:51 INFO - 'sessionrestore_no_auto_restore']}, 20:39:51 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 20:39:51 INFO - 'tests': ['a11yr', 20:39:51 INFO - 'ts_paint', 20:39:51 INFO - 'tpaint', 20:39:51 INFO - 'sessionrestore', 20:39:51 INFO - 'sessionrestore_no_auto_restore']}, 20:39:51 INFO - 'other_l64': {'tests': ['a11yr', 20:39:51 INFO - 'ts_paint', 20:39:51 INFO - 'tpaint', 20:39:51 INFO - 'sessionrestore', 20:39:51 INFO - 'sessionrestore_no_auto_restore']}, 20:39:51 INFO - 'other_nol64': {'tests': ['a11yr', 20:39:51 INFO - 'ts_paint', 20:39:51 INFO - 'tpaint', 20:39:51 INFO - 'sessionrestore', 20:39:51 INFO - 'sessionrestore_no_auto_restore']}, 20:39:51 INFO - 'svgr': {'tests': ['tsvgx', 20:39:51 INFO - 'tsvgr_opacity', 20:39:51 INFO - 'tart', 20:39:51 INFO - 'tscrollx', 20:39:51 INFO - 'cart']}, 20:39:51 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 20:39:51 INFO - 'tests': ['tsvgx', 20:39:51 INFO - 'tsvgr_opacity', 20:39:51 INFO - 'tart', 20:39:51 INFO - 'tscrollx', 20:39:51 INFO - 'cart']}, 20:39:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:39:51 INFO - 'tests': ['tp5o']}, 20:39:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:39:51 INFO - 'talos_options': ['--e10s'], 20:39:51 INFO - 'tests': ['tp5o']}, 20:39:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:39:51 INFO - 'talos_options': ['--xperf_path', 20:39:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:39:51 INFO - 'tests': ['tp5n']}, 20:39:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:39:51 INFO - 'talos_options': ['--e10s', 20:39:51 INFO - '--xperf_path', 20:39:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:39:51 INFO - 'tests': ['tp5n']}}, 20:39:51 INFO - 'talos.zip': {'path': '', 20:39:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:39:51 INFO - Running post-action listener: _resource_record_post_action 20:39:51 INFO - ##### 20:39:51 INFO - ##### Running create-virtualenv step. 20:39:51 INFO - ##### 20:39:51 INFO - Running pre-action listener: _resource_record_pre_action 20:39:51 INFO - Running main action method: create_virtualenv 20:39:51 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 20:39:51 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 20:39:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 20:39:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:39:51 INFO - Using real prefix '/usr' 20:39:51 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 20:39:52 INFO - Installing distribute.............................................................................................................................................................................................done. 20:39:54 INFO - Installing pip.................done. 20:39:54 INFO - Return code: 0 20:39:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 20:39:54 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')]} 20:39:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:39:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:39:54 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')]} 20:39:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:39:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:39:54 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 0x7f670c3ecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27bb600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x284a350>, '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 0x284b250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x284b6e0>, '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': 'ae8083fbfc14dfa356ee9053000001f7-1451448626.518699-1847082600', '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 20:39:54 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 20:39:54 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 20:39:54 INFO - Using env: {'DISPLAY': ':0', 20:39:54 INFO - 'HOME': '/home/cltbld', 20:39:54 INFO - 'LANG': 'en_US.UTF-8', 20:39:54 INFO - 'LANGUAGE': 'en_US:en', 20:39:54 INFO - 'LOGNAME': 'cltbld', 20:39:54 INFO - 'MAIL': '/var/mail/cltbld', 20:39:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:39:54 INFO - 'MOZ_NO_REMOTE': '1', 20:39:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:39:54 INFO - 'NO_EM_RESTART': '1', 20:39:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:39:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:39:54 INFO - 'PWD': '/builds/slave/test-pgo', 20:39:54 INFO - 'SHELL': '/bin/bash', 20:39:54 INFO - 'SHLVL': '1', 20:39:54 INFO - 'TERM': 'linux', 20:39:54 INFO - 'TMOUT': '86400', 20:39:54 INFO - 'USER': 'cltbld', 20:39:54 INFO - 'XDG_SESSION_COOKIE': 'ae8083fbfc14dfa356ee9053000001f7-1451448626.518699-1847082600', 20:39:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:39:54 INFO - '_': '/tools/buildbot/bin/python'} 20:39:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:39:54 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 20:39:54 INFO - Cleaning up... 20:39:54 INFO - Return code: 0 20:39:54 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 20:39:54 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')]} 20:39:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:39:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:39:54 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')]} 20:39:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:39:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:39:54 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 0x7f670c3ecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27bb600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x284a350>, '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 0x284b250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x284b6e0>, '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': 'ae8083fbfc14dfa356ee9053000001f7-1451448626.518699-1847082600', '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 20:39:54 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 20:39:54 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 20:39:54 INFO - Using env: {'DISPLAY': ':0', 20:39:54 INFO - 'HOME': '/home/cltbld', 20:39:54 INFO - 'LANG': 'en_US.UTF-8', 20:39:54 INFO - 'LANGUAGE': 'en_US:en', 20:39:54 INFO - 'LOGNAME': 'cltbld', 20:39:54 INFO - 'MAIL': '/var/mail/cltbld', 20:39:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:39:54 INFO - 'MOZ_NO_REMOTE': '1', 20:39:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:39:54 INFO - 'NO_EM_RESTART': '1', 20:39:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:39:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:39:54 INFO - 'PWD': '/builds/slave/test-pgo', 20:39:54 INFO - 'SHELL': '/bin/bash', 20:39:54 INFO - 'SHLVL': '1', 20:39:54 INFO - 'TERM': 'linux', 20:39:54 INFO - 'TMOUT': '86400', 20:39:54 INFO - 'USER': 'cltbld', 20:39:54 INFO - 'XDG_SESSION_COOKIE': 'ae8083fbfc14dfa356ee9053000001f7-1451448626.518699-1847082600', 20:39:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:39:54 INFO - '_': '/tools/buildbot/bin/python'} 20:39:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:39:54 INFO - Downloading/unpacking psutil>=0.7.1 20:39:54 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 20:39:54 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 20:39:54 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 20:39:54 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 20:39:54 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 20:39:54 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 20:39:56 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 20:39:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 20:39:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 20:39:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:39:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:39:56 INFO - Installing collected packages: psutil 20:39:56 INFO - Running setup.py install for psutil 20:39:56 INFO - building 'psutil._psutil_linux' extension 20:39:56 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 20:39:56 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 20:39:56 INFO - building 'psutil._psutil_posix' extension 20:39:56 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 20:39:56 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 20:39:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:39:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:39:56 INFO - Successfully installed psutil 20:39:56 INFO - Cleaning up... 20:39:56 INFO - Return code: 0 20:39:56 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 20:39:56 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')]} 20:39:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:39:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:39:56 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')]} 20:39:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:39:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:39:56 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 0x7f670c3ecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27bb600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x284a350>, '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 0x284b250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x284b6e0>, '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': 'ae8083fbfc14dfa356ee9053000001f7-1451448626.518699-1847082600', '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 20:39:56 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 20:39:56 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 20:39:56 INFO - Using env: {'DISPLAY': ':0', 20:39:56 INFO - 'HOME': '/home/cltbld', 20:39:56 INFO - 'LANG': 'en_US.UTF-8', 20:39:56 INFO - 'LANGUAGE': 'en_US:en', 20:39:56 INFO - 'LOGNAME': 'cltbld', 20:39:56 INFO - 'MAIL': '/var/mail/cltbld', 20:39:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:39:56 INFO - 'MOZ_NO_REMOTE': '1', 20:39:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:39:56 INFO - 'NO_EM_RESTART': '1', 20:39:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:39:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:39:56 INFO - 'PWD': '/builds/slave/test-pgo', 20:39:56 INFO - 'SHELL': '/bin/bash', 20:39:56 INFO - 'SHLVL': '1', 20:39:56 INFO - 'TERM': 'linux', 20:39:56 INFO - 'TMOUT': '86400', 20:39:56 INFO - 'USER': 'cltbld', 20:39:56 INFO - 'XDG_SESSION_COOKIE': 'ae8083fbfc14dfa356ee9053000001f7-1451448626.518699-1847082600', 20:39:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:39:56 INFO - '_': '/tools/buildbot/bin/python'} 20:39:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:39:57 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 20:39:57 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 20:39:57 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 20:39:57 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 20:39:57 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 20:39:57 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 20:39:57 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 20:39:58 INFO - Downloading mozsystemmonitor-0.0.tar.gz 20:39:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 20:39:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:39:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 20:39:58 INFO - Installing collected packages: mozsystemmonitor 20:39:58 INFO - Running setup.py install for mozsystemmonitor 20:39:58 INFO - Successfully installed mozsystemmonitor 20:39:58 INFO - Cleaning up... 20:39:58 INFO - Return code: 0 20:39:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 20:39:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:39:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:39:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:39:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:39:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:39:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:39:58 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 0x7f670c3ecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27bb600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x284a350>, '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 0x284b250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x284b6e0>, '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': 'ae8083fbfc14dfa356ee9053000001f7-1451448626.518699-1847082600', '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 20:39:58 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 20:39:58 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 20:39:58 INFO - Using env: {'DISPLAY': ':0', 20:39:58 INFO - 'HOME': '/home/cltbld', 20:39:58 INFO - 'LANG': 'en_US.UTF-8', 20:39:58 INFO - 'LANGUAGE': 'en_US:en', 20:39:58 INFO - 'LOGNAME': 'cltbld', 20:39:58 INFO - 'MAIL': '/var/mail/cltbld', 20:39:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:39:58 INFO - 'MOZ_NO_REMOTE': '1', 20:39:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:39:58 INFO - 'NO_EM_RESTART': '1', 20:39:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:39:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:39:58 INFO - 'PWD': '/builds/slave/test-pgo', 20:39:58 INFO - 'SHELL': '/bin/bash', 20:39:58 INFO - 'SHLVL': '1', 20:39:58 INFO - 'TERM': 'linux', 20:39:58 INFO - 'TMOUT': '86400', 20:39:58 INFO - 'USER': 'cltbld', 20:39:58 INFO - 'XDG_SESSION_COOKIE': 'ae8083fbfc14dfa356ee9053000001f7-1451448626.518699-1847082600', 20:39:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:39:58 INFO - '_': '/tools/buildbot/bin/python'} 20:39:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:39:59 INFO - Downloading/unpacking blobuploader==1.2.4 20:39:59 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 20:39:59 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 20:39:59 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 20:39:59 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 20:39:59 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 20:39:59 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 20:40:00 INFO - Downloading blobuploader-1.2.4.tar.gz 20:40:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 20:40:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:40:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:40:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:40:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:40:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:40:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:40:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:40:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:40:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 20:40:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 20:40:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:40:01 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 20:40:01 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 20:40:01 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 20:40:01 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 20:40:01 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 20:40:01 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 20:40:01 INFO - Downloading docopt-0.6.1.tar.gz 20:40:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 20:40:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 20:40:01 INFO - Installing collected packages: blobuploader, requests, docopt 20:40:01 INFO - Running setup.py install for blobuploader 20:40:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:40:01 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 20:40:01 INFO - Running setup.py install for requests 20:40:01 INFO - Running setup.py install for docopt 20:40:02 INFO - Successfully installed blobuploader requests docopt 20:40:02 INFO - Cleaning up... 20:40:02 INFO - Return code: 0 20:40:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 20:40:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:40:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:40:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:40:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:40:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:40:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:40:02 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 0x7f670c3ecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27bb600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x284a350>, '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 0x284b250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x284b6e0>, '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': 'ae8083fbfc14dfa356ee9053000001f7-1451448626.518699-1847082600', '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 20:40:02 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 20:40:02 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 20:40:02 INFO - Using env: {'DISPLAY': ':0', 20:40:02 INFO - 'HOME': '/home/cltbld', 20:40:02 INFO - 'LANG': 'en_US.UTF-8', 20:40:02 INFO - 'LANGUAGE': 'en_US:en', 20:40:02 INFO - 'LOGNAME': 'cltbld', 20:40:02 INFO - 'MAIL': '/var/mail/cltbld', 20:40:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:40:02 INFO - 'MOZ_NO_REMOTE': '1', 20:40:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:40:02 INFO - 'NO_EM_RESTART': '1', 20:40:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:40:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:40:02 INFO - 'PWD': '/builds/slave/test-pgo', 20:40:02 INFO - 'SHELL': '/bin/bash', 20:40:02 INFO - 'SHLVL': '1', 20:40:02 INFO - 'TERM': 'linux', 20:40:02 INFO - 'TMOUT': '86400', 20:40:02 INFO - 'USER': 'cltbld', 20:40:02 INFO - 'XDG_SESSION_COOKIE': 'ae8083fbfc14dfa356ee9053000001f7-1451448626.518699-1847082600', 20:40:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:40:02 INFO - '_': '/tools/buildbot/bin/python'} 20:40:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:40:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:40:02 INFO - Running setup.py (path:/tmp/pip-k392c5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:40:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:40:02 INFO - Running setup.py (path:/tmp/pip-BwIUDN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:40:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:40:02 INFO - Running setup.py (path:/tmp/pip-y8vhkH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:40:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:40:02 INFO - Running setup.py (path:/tmp/pip-OZuIwk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:40:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 20:40:02 INFO - Running setup.py (path:/tmp/pip-MwEpgb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 20:40:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:40:02 INFO - Running setup.py (path:/tmp/pip-snwyqr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:40:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:40:02 INFO - Running setup.py (path:/tmp/pip-KQmTt7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:40:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:40:02 INFO - Running setup.py (path:/tmp/pip-k7T4cn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:40:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 20:40:02 INFO - Running setup.py (path:/tmp/pip-ntD7Sn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 20:40:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 20:40:02 INFO - Running setup.py (path:/tmp/pip-wS4j8n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 20:40:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:40:03 INFO - Running setup.py (path:/tmp/pip-igOpHB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:40:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:40:03 INFO - Running setup.py (path:/tmp/pip-8TEXnn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:40:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:40:03 INFO - Running setup.py (path:/tmp/pip-ZUaFnU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:40:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:40:03 INFO - Running setup.py (path:/tmp/pip-npucgG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:40:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:40:03 INFO - Running setup.py (path:/tmp/pip-U0QLH6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:40:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 20:40:03 INFO - Running setup.py (path:/tmp/pip-wKhvKJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 20:40:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 20:40:03 INFO - Running setup.py (path:/tmp/pip-MbBjGE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 20:40:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:40:03 INFO - Running setup.py install for manifestparser 20:40:03 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 20:40:03 INFO - Running setup.py install for mozcrash 20:40:03 INFO - Running setup.py install for mozdebug 20:40:03 INFO - Running setup.py install for mozdevice 20:40:04 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 20:40:04 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 20:40:04 INFO - Running setup.py install for mozfile 20:40:04 INFO - Running setup.py install for mozhttpd 20:40:04 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 20:40:04 INFO - Running setup.py install for mozinfo 20:40:04 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 20:40:04 INFO - Running setup.py install for mozInstall 20:40:04 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 20:40:04 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 20:40:04 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 20:40:04 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 20:40:04 INFO - Running setup.py install for mozleak 20:40:04 INFO - Running setup.py install for mozlog 20:40:04 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 20:40:04 INFO - Running setup.py install for moznetwork 20:40:04 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 20:40:04 INFO - Running setup.py install for mozprocess 20:40:04 INFO - Running setup.py install for mozprofile 20:40:04 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 20:40:04 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 20:40:04 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 20:40:04 INFO - Running setup.py install for mozrunner 20:40:05 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 20:40:05 INFO - Running setup.py install for mozscreenshot 20:40:05 INFO - Running setup.py install for moztest 20:40:05 INFO - Running setup.py install for mozversion 20:40:05 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 20:40:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:40:05 INFO - Cleaning up... 20:40:05 INFO - Return code: 0 20:40:05 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 20:40:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:40:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:40:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:40:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:40:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:40:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:40:05 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f670c3ecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27bb600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x284a350>, '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 0x284b250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x284b6e0>, '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': 'ae8083fbfc14dfa356ee9053000001f7-1451448626.518699-1847082600', '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 20:40:05 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 20:40:05 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 20:40:05 INFO - Using env: {'DISPLAY': ':0', 20:40:05 INFO - 'HOME': '/home/cltbld', 20:40:05 INFO - 'LANG': 'en_US.UTF-8', 20:40:05 INFO - 'LANGUAGE': 'en_US:en', 20:40:05 INFO - 'LOGNAME': 'cltbld', 20:40:05 INFO - 'MAIL': '/var/mail/cltbld', 20:40:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:40:05 INFO - 'MOZ_NO_REMOTE': '1', 20:40:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:40:05 INFO - 'NO_EM_RESTART': '1', 20:40:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:40:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:40:05 INFO - 'PWD': '/builds/slave/test-pgo', 20:40:05 INFO - 'SHELL': '/bin/bash', 20:40:05 INFO - 'SHLVL': '1', 20:40:05 INFO - 'TERM': 'linux', 20:40:05 INFO - 'TMOUT': '86400', 20:40:05 INFO - 'USER': 'cltbld', 20:40:05 INFO - 'XDG_SESSION_COOKIE': 'ae8083fbfc14dfa356ee9053000001f7-1451448626.518699-1847082600', 20:40:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:40:05 INFO - '_': '/tools/buildbot/bin/python'} 20:40:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:40:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:40:05 INFO - Running setup.py (path:/tmp/pip-Ek8nk_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:40:05 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)) 20:40:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:40:05 INFO - Running setup.py (path:/tmp/pip-t3_0uw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:40:05 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)) 20:40:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:40:05 INFO - Running setup.py (path:/tmp/pip-RkiQBM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:40:05 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)) 20:40:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:40:05 INFO - Running setup.py (path:/tmp/pip-wNjp9F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:40:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.46 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)) 20:40:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 20:40:05 INFO - Running setup.py (path:/tmp/pip-o8HCf7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 20:40:05 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)) 20:40:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:40:05 INFO - Running setup.py (path:/tmp/pip-7GGKjX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:40:06 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)) 20:40:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:40:06 INFO - Running setup.py (path:/tmp/pip-BPX1H0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:40:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.8 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)) 20:40:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:40:06 INFO - Running setup.py (path:/tmp/pip-hZo8Ro-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:40:06 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)) 20:40:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 20:40:06 INFO - Running setup.py (path:/tmp/pip-iyWmok-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 20:40:06 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)) 20:40:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 20:40:06 INFO - Running setup.py (path:/tmp/pip-I1a139-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 20:40:06 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)) 20:40:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:40:06 INFO - Running setup.py (path:/tmp/pip-Evl22U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:40:06 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)) 20:40:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:40:06 INFO - Running setup.py (path:/tmp/pip-voTcb8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:40:06 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)) 20:40:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:40:06 INFO - Running setup.py (path:/tmp/pip-t1kbZu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:40:06 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)) 20:40:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:40:06 INFO - Running setup.py (path:/tmp/pip-JhAjgF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:40:06 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)) 20:40:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:40:06 INFO - Running setup.py (path:/tmp/pip-9cxO5_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:40:06 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)) 20:40:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 20:40:06 INFO - Running setup.py (path:/tmp/pip-a5NAbd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 20:40:06 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)) 20:40:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 20:40:06 INFO - Running setup.py (path:/tmp/pip-4Ajgn7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 20:40:06 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)) 20:40:06 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)) 20:40:06 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)) 20:40:06 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)) 20:40:06 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.46->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 20:40:06 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.46->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 20:40:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 20:40:06 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 20:40:06 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 20:40:06 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 20:40:06 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 20:40:06 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 20:40:06 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 20:40:08 INFO - Downloading blessings-1.5.1.tar.gz 20:40:08 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 20:40:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 20:40:08 INFO - Installing collected packages: blessings 20:40:08 INFO - Running setup.py install for blessings 20:40:08 INFO - Successfully installed blessings 20:40:08 INFO - Cleaning up... 20:40:08 INFO - Return code: 0 20:40:08 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 20:40:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 20:40:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 20:40:08 INFO - Reading from file tmpfile_stdout 20:40:08 INFO - Current package versions: 20:40:08 INFO - argparse == 1.2.1 20:40:08 INFO - blessings == 1.5.1 20:40:08 INFO - blobuploader == 1.2.4 20:40:08 INFO - docopt == 0.6.1 20:40:08 INFO - manifestparser == 1.1 20:40:08 INFO - mozInstall == 1.12 20:40:08 INFO - mozcrash == 0.16 20:40:08 INFO - mozdebug == 0.1 20:40:08 INFO - mozdevice == 0.46 20:40:08 INFO - mozfile == 1.2 20:40:08 INFO - mozhttpd == 0.7 20:40:08 INFO - mozinfo == 0.8 20:40:08 INFO - mozleak == 0.1 20:40:08 INFO - mozlog == 3.0 20:40:08 INFO - moznetwork == 0.27 20:40:08 INFO - mozprocess == 0.22 20:40:08 INFO - mozprofile == 0.27 20:40:08 INFO - mozrunner == 6.11 20:40:08 INFO - mozscreenshot == 0.1 20:40:08 INFO - mozsystemmonitor == 0.0 20:40:08 INFO - moztest == 0.7 20:40:08 INFO - mozversion == 1.4 20:40:08 INFO - psutil == 3.1.1 20:40:08 INFO - requests == 1.2.3 20:40:08 INFO - wsgiref == 0.1.2 20:40:08 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 20:40:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:40:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:40:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:40:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:40:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:40:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:40:08 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 0x7f670c3ecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27bb600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x284a350>, '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 0x284b250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x284b6e0>, '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': 'ae8083fbfc14dfa356ee9053000001f7-1451448626.518699-1847082600', '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 20:40:08 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 20:40:08 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 20:40:08 INFO - Using env: {'DISPLAY': ':0', 20:40:08 INFO - 'HOME': '/home/cltbld', 20:40:08 INFO - 'LANG': 'en_US.UTF-8', 20:40:08 INFO - 'LANGUAGE': 'en_US:en', 20:40:08 INFO - 'LOGNAME': 'cltbld', 20:40:08 INFO - 'MAIL': '/var/mail/cltbld', 20:40:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:40:08 INFO - 'MOZ_NO_REMOTE': '1', 20:40:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:40:08 INFO - 'NO_EM_RESTART': '1', 20:40:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:40:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:40:08 INFO - 'PWD': '/builds/slave/test-pgo', 20:40:08 INFO - 'SHELL': '/bin/bash', 20:40:08 INFO - 'SHLVL': '1', 20:40:08 INFO - 'TERM': 'linux', 20:40:08 INFO - 'TMOUT': '86400', 20:40:08 INFO - 'USER': 'cltbld', 20:40:08 INFO - 'XDG_SESSION_COOKIE': 'ae8083fbfc14dfa356ee9053000001f7-1451448626.518699-1847082600', 20:40:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:40:08 INFO - '_': '/tools/buildbot/bin/python'} 20:40:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:40:09 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)) 20:40:09 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)) 20:40:09 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)) 20:40:09 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)) 20:40:09 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)) 20:40:09 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)) 20:40:09 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)) 20:40:09 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)) 20:40:09 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)) 20:40:09 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)) 20:40:09 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)) 20:40:09 INFO - Cleaning up... 20:40:09 INFO - Return code: 0 20:40:09 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 20:40: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')]} 20:40:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:40:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:40: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')]} 20:40:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:40:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:40:09 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f670c3ecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27bb600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x284a350>, '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 0x284b250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x284b6e0>, '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': 'ae8083fbfc14dfa356ee9053000001f7-1451448626.518699-1847082600', '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 20:40:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 20:40:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 20:40:09 INFO - Using env: {'DISPLAY': ':0', 20:40:09 INFO - 'HOME': '/home/cltbld', 20:40:09 INFO - 'LANG': 'en_US.UTF-8', 20:40:09 INFO - 'LANGUAGE': 'en_US:en', 20:40:09 INFO - 'LOGNAME': 'cltbld', 20:40:09 INFO - 'MAIL': '/var/mail/cltbld', 20:40:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:40:09 INFO - 'MOZ_NO_REMOTE': '1', 20:40:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:40:09 INFO - 'NO_EM_RESTART': '1', 20:40:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:40:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:40:09 INFO - 'PWD': '/builds/slave/test-pgo', 20:40:09 INFO - 'SHELL': '/bin/bash', 20:40:09 INFO - 'SHLVL': '1', 20:40:09 INFO - 'TERM': 'linux', 20:40:09 INFO - 'TMOUT': '86400', 20:40:09 INFO - 'USER': 'cltbld', 20:40:09 INFO - 'XDG_SESSION_COOKIE': 'ae8083fbfc14dfa356ee9053000001f7-1451448626.518699-1847082600', 20:40:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:40:09 INFO - '_': '/tools/buildbot/bin/python'} 20:40:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:40:09 INFO - Downloading/unpacking jsonschema 20:40:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:40:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:40:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:40:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:40:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:40:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:40:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:40:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 20:40:11 INFO - Downloading/unpacking functools32 (from jsonschema) 20:40:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:40:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:40:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:40:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:40:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:40:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:40:11 INFO - Downloading functools32-3.2.3-2.tar.gz 20:40:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 20:40:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 20:40:11 INFO - warning: no files found matching '*.txt' 20:40:11 INFO - no previously-included directories found matching 'build' 20:40:11 INFO - no previously-included directories found matching 'dist' 20:40:11 INFO - no previously-included directories found matching '.git*' 20:40:11 INFO - Installing collected packages: jsonschema, functools32 20:40:11 INFO - Running setup.py install for functools32 20:40:11 INFO - warning: no files found matching '*.txt' 20:40:11 INFO - no previously-included directories found matching 'build' 20:40:11 INFO - no previously-included directories found matching 'dist' 20:40:11 INFO - no previously-included directories found matching '.git*' 20:40:11 INFO - Successfully installed jsonschema functools32 20:40:11 INFO - Cleaning up... 20:40:11 INFO - Return code: 0 20:40:11 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 20:40:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:40:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:40:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:40:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:40:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:40:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:40:11 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f670c3ecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27bb600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x284a350>, '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 0x284b250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x284b6e0>, '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': 'ae8083fbfc14dfa356ee9053000001f7-1451448626.518699-1847082600', '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 20:40:11 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 20:40:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 20:40:11 INFO - Using env: {'DISPLAY': ':0', 20:40:11 INFO - 'HOME': '/home/cltbld', 20:40:11 INFO - 'LANG': 'en_US.UTF-8', 20:40:11 INFO - 'LANGUAGE': 'en_US:en', 20:40:11 INFO - 'LOGNAME': 'cltbld', 20:40:11 INFO - 'MAIL': '/var/mail/cltbld', 20:40:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:40:11 INFO - 'MOZ_NO_REMOTE': '1', 20:40:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:40:11 INFO - 'NO_EM_RESTART': '1', 20:40:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:40:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:40:11 INFO - 'PWD': '/builds/slave/test-pgo', 20:40:11 INFO - 'SHELL': '/bin/bash', 20:40:11 INFO - 'SHLVL': '1', 20:40:11 INFO - 'TERM': 'linux', 20:40:11 INFO - 'TMOUT': '86400', 20:40:11 INFO - 'USER': 'cltbld', 20:40:11 INFO - 'XDG_SESSION_COOKIE': 'ae8083fbfc14dfa356ee9053000001f7-1451448626.518699-1847082600', 20:40:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:40:11 INFO - '_': '/tools/buildbot/bin/python'} 20:40:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:40:11 INFO - Downloading/unpacking flake8 20:40:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:40:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:40:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:40:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:40:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:40:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:40:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:40:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 20:40:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:40:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:40:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:40:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:40:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:40:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:40:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:40:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:40:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 20:40:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:40:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:40:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:40:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:40:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:40:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:40:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:40:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 20:40:14 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:40:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:40:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:40:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:40:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:40:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:40:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:40:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 20:40:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 20:40:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:40:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:40:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:40:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:40:14 INFO - no previously-included directories found matching 'docs/_build' 20:40:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:40:14 INFO - Running setup.py install for pep8 20:40:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:40:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:40:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:40:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:40:15 INFO - no previously-included directories found matching 'docs/_build' 20:40:15 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 20:40:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:40:15 INFO - Cleaning up... 20:40:15 INFO - Return code: 0 20:40:15 INFO - Running post-action listener: _resource_record_post_action 20:40:15 INFO - Running post-action listener: _start_resource_monitoring 20:40:15 INFO - Starting resource monitoring. 20:40:15 INFO - ##### 20:40:15 INFO - ##### Running install step. 20:40:15 INFO - ##### 20:40:15 INFO - Running pre-action listener: _resource_record_pre_action 20:40:15 INFO - Running main action method: install 20:40:15 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 20:40:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 20:40:15 INFO - Reading from file tmpfile_stdout 20:40:15 INFO - Detecting whether we're running mozinstall >=1.0... 20:40:15 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 20:40:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 20:40:15 INFO - Reading from file tmpfile_stdout 20:40:15 INFO - Output received: 20:40:15 INFO - Usage: mozinstall [options] installer 20:40:15 INFO - Options: 20:40:15 INFO - -h, --help show this help message and exit 20:40:15 INFO - -d DEST, --destination=DEST 20:40:15 INFO - Directory to install application into. [default: 20:40:15 INFO - "/builds/slave/test-pgo"] 20:40:15 INFO - --app=APP Application being installed. [default: firefox] 20:40:15 INFO - mkdir: /builds/slave/test-pgo/build/application 20:40:15 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 20:40:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 20:40:29 INFO - Reading from file tmpfile_stdout 20:40:29 INFO - Output received: 20:40:29 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 20:40:29 INFO - Running post-action listener: _resource_record_post_action 20:40:29 INFO - ##### 20:40:29 INFO - ##### Running run-tests step. 20:40:29 INFO - ##### 20:40:29 INFO - Running pre-action listener: _resource_record_pre_action 20:40:29 INFO - Running main action method: run_tests 20:40:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 20:40:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 20:40:29 INFO - Python 2.7.3 20:40:29 INFO - Return code: 0 20:40:29 INFO - grabbing minidump binary from tooltool 20:40: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')]} 20:40:29 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 0x284a350>, '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 0x284b250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x284b6e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 20:40:29 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 20:40:29 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 20:40:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:40:29 INFO - Return code: 0 20:40:29 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 20:40:29 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 20:40:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 20:40:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 20:40:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 20:40:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 20:40:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 20:40:30 INFO - Return code: 0 20:40:30 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-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1451442639/firefox-44.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 20:40:30 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-Beta --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1451442639/firefox-44.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-043 --webServer localhost 20:40:30 INFO - Using env: {'DISPLAY': ':0', 20:40:30 INFO - 'HOME': '/home/cltbld', 20:40:30 INFO - 'LANG': 'en_US.UTF-8', 20:40:30 INFO - 'LANGUAGE': 'en_US:en', 20:40:30 INFO - 'LOGNAME': 'cltbld', 20:40:30 INFO - 'MAIL': '/var/mail/cltbld', 20:40:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 20:40:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 20:40:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:40:30 INFO - 'MOZ_NO_REMOTE': '1', 20:40:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 20:40:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:40:30 INFO - 'NO_EM_RESTART': '1', 20:40:30 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:40:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:40:30 INFO - 'PWD': '/builds/slave/test-pgo', 20:40:30 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 20:40:30 INFO - 'SHELL': '/bin/bash', 20:40:30 INFO - 'SHLVL': '1', 20:40:30 INFO - 'TERM': 'linux', 20:40:30 INFO - 'TMOUT': '86400', 20:40:30 INFO - 'USER': 'cltbld', 20:40:30 INFO - 'XDG_SESSION_COOKIE': 'ae8083fbfc14dfa356ee9053000001f7-1451448626.518699-1847082600', 20:40:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:40:30 INFO - '_': '/tools/buildbot/bin/python'} 20:40:30 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1451442639/firefox-44.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--webServer', 'localhost'] with output_timeout 3600 20:40:30 INFO - mozversion INFO | application_buildid: 20151229183039 20:40:30 INFO - mozversion INFO | application_changeset: bc679c4aeb59f7712abaa3edff02debfef8ff317 20:40:30 INFO - mozversion INFO | application_display_name: Nightly 20:40:30 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:40:30 INFO - mozversion INFO | application_name: Firefox 20:40:30 INFO - mozversion INFO | application_remotingname: firefox 20:40:30 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-beta 20:40:30 INFO - mozversion INFO | application_vendor: Mozilla 20:40:30 INFO - mozversion INFO | application_version: 44.0 20:40:30 INFO - mozversion INFO | platform_buildid: 20151229183039 20:40:30 INFO - mozversion INFO | platform_changeset: bc679c4aeb59f7712abaa3edff02debfef8ff317 20:40:30 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-beta 20:40:30 INFO - mozversion INFO | platform_version: 44.0 20:40:30 INFO - 2015-12-29 20:40:30,837 DEBUG : using testdate: 1451450430 20:40:30 INFO - 2015-12-29 20:40:30,837 DEBUG : actual date: 1451450430 20:40:30 INFO - 2015-12-29 20:40:30,924 INFO : starting webserver on 'localhost:54114' 20:40:30 INFO - 2015-12-29 20:40:30,925 INFO : Starting test suite talos-linux64-ix-043 20:40:30 INFO - 2015-12-29 20:40:30,925 INFO : Starting test dromaeo_css 20:40:30 INFO - 2015-12-29 20:40:30,925 DEBUG : operating with platform_type : linux_ 20:40:30 INFO - 2015-12-29 20:40:30,926 INFO : Initialising browser for dromaeo_css test... 20:40:30 INFO - 2015-12-29 20:40:30,942 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUT7RSR/profile http://localhost:54114/getInfo.html 20:40:34 INFO - 2015-12-29 20:40:34,667 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 20:40:34 INFO - 2015-12-29 20:40:34,667 DEBUG : BROWSER_OUTPUT: colorDepth:24 20:40:34 INFO - 2015-12-29 20:40:34,667 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 20:40:34 INFO - 2015-12-29 20:40:34,667 DEBUG : BROWSER_OUTPUT: __metrics 20:40:34 INFO - 2015-12-29 20:40:34,804 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:40:36 INFO - 2015-12-29 20:40:36,026 INFO : Browser initialized. 20:40:36 INFO - 2015-12-29 20:40:36,026 INFO : Running cycle 1/1 for dromaeo_css test... 20:40:36 INFO - 2015-12-29 20:40:36,027 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUT7RSR/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 20:40:47 INFO - 2015-12-29 20:40:47,496 DEBUG : BROWSER_OUTPUT: RSS: Main: 128552960 20:40:47 INFO - 2015-12-29 20:40:47,497 DEBUG : BROWSER_OUTPUT: 20:41:38 INFO - 2015-12-29 20:41:38,327 DEBUG : BROWSER_OUTPUT: 1451450498322 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] 20:43:46 INFO - 2015-12-29 20:43:46,212 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54114/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54114/tests/dromaeo/cssquery-ext.html) 20:43:47 INFO - 2015-12-29 20:43:47,288 DEBUG : BROWSER_OUTPUT: RSS: Main: 205488128 20:43:47 INFO - 2015-12-29 20:43:47,288 DEBUG : BROWSER_OUTPUT: 20:46:49 INFO - 2015-12-29 20:46:49,342 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54114/tests/dromaeo/cssquery-ext.html (next: http://localhost:54114/tests/dromaeo/cssquery-jquery.html) 20:46:49 INFO - 2015-12-29 20:46:49,896 DEBUG : BROWSER_OUTPUT: RSS: Main: 203595776 20:46:49 INFO - 2015-12-29 20:46:49,896 DEBUG : BROWSER_OUTPUT: 20:49:51 INFO - 2015-12-29 20:49:51,607 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54114/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54114/tests/dromaeo/cssquery-mootools.html) 20:49:52 INFO - 2015-12-29 20:49:52,170 DEBUG : BROWSER_OUTPUT: RSS: Main: 202539008 20:49:52 INFO - 2015-12-29 20:49:52,170 DEBUG : BROWSER_OUTPUT: 20:52:53 INFO - 2015-12-29 20:52:53,854 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54114/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54114/tests/dromaeo/cssquery-prototype.html) 20:52:54 INFO - 2015-12-29 20:52:54,418 DEBUG : BROWSER_OUTPUT: RSS: Main: 192004096 20:52:54 INFO - 2015-12-29 20:52:54,418 DEBUG : BROWSER_OUTPUT: 20:55:56 INFO - 2015-12-29 20:55:56,828 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54114/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54114/tests/dromaeo/cssquery-yui.html) 20:55:57 INFO - 2015-12-29 20:55:57,390 DEBUG : BROWSER_OUTPUT: RSS: Main: 193331200 20:55:57 INFO - 2015-12-29 20:55:57,390 DEBUG : BROWSER_OUTPUT: 20:58:59 INFO - 2015-12-29 20:58:59,394 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54114/tests/dromaeo/cssquery-yui.html (next: http://localhost:54114/tests/dromaeo/cssquery-dojo.html) 20:58:59 INFO - 2015-12-29 20:58:59,652 DEBUG : BROWSER_OUTPUT: RSS: Main: 220528640 20:58:59 INFO - 2015-12-29 20:58:59,652 DEBUG : BROWSER_OUTPUT: 20:58:59 INFO - 2015-12-29 20:58:59,652 DEBUG : BROWSER_OUTPUT: __start_tp_report 20:58:59 INFO - 2015-12-29 20:58:59,652 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 20:58:59 INFO - 2015-12-29 20:58:59,653 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 20:58:59 INFO - 2015-12-29 20:58:59,653 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 20:58:59 INFO - 2015-12-29 20:58:59,653 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3308.6029676438825;3389.593248810143;3419.675130862569;3419.9911026247237;3456.8444420001097;5594.076977298746;5640.294963129609;5670.631408958415;5675.914861277084;5677.545796336293;5637.098064309711;5644.8024319148835;5655.971720141393;5666.461686139821;5701.173329867167;4958.231474121517;5154.92267615986;5170.121079416508;5242.030224408478;5253.553447956909;5098.311727916739;5108.284840122367;5131.948680513185;5135.871603209931;5137.049645815536;5053.267276244942;5067.923981140268;5172;5179.766910489018;5180.974095129538;5157.5100365465405;5158.303629010092;5166.483351664803;5166.7416629168765;5170.172772356443;5091.9236211456855;5136.84589462313;5196.8960620787375;5201.271821944931;5275.050490911634;5205.817796377109;5289.656172348785;5314;5406.648567843077;5430.185472179165;6059.7273122709585;6138.0792881067755;6159.661218632973;6161.476274516672;6179.196704428396;5850.6782126983;6212.81361559154;6217.626942383471;6222.875542489171;6230.906536401958;5598.804041858556;5607.663540187602;5729.455701708331;5734.111212761987;5764.654120752768;6167.629942203482;6185.783497577563;6194.101855230966;6196.752129914753;6196.907046394308;5733.283339582552;5841.824745257649;6003.489703375262;6031.728572214173;6035.818925432244;5919.200907877467;6055.303640081359;6065.120557519135;6067.878642427127;6087.939120608826;6041.305249896318;6086.391360863967;6088.086786981989;6092.7562897484495;6096.329403765582;5845.240118784616;5951.464368206795;5992.550558708114;6045.21412216409;6073.726682299307;4554.863354099382;4599.701019433726;4602.608778253819;4642.5821676048645;4661.790219440133;4179.26862799009;4216.662666986634;4229.703920725581;4232.36514522824;4247.766372849523;5563.916541251884;5802.187693722883;5856.531477481792;5863;5865.266841644794;5948.315943666447;5974;6035.1249068885645;6040.365761595057;6067;5680.630759000652;5694.515966142924;5697.715114244271;5697.800576979786;5700.6009579329875;5078.5175408336145;5190.792368305226;5272.209168624737;5298;5309.203619457112;6184.350643182491;6279.434850863353;6306.211723534559;6313.9368606314265;6314.084457753692;6030.758769649165;6113.14415981754;6118.143459915705;6119.602225855305;6122.724477398617;6105.84735381619;6139.048447490646;6212.1303017578475;6310.558260921692;6333.145025421509;6037.698115094316;6039.335673076046;6039.909401359071;6044.969775151096;6048.183495228088;6132.325444201224;6137.754489820536;6141.570090093651;6144.047672610753;6144.262688477412;5685.346185188756;5763;5852.7658893643775;5978.432048955342;5979.103134529855;5884.7940322088525;5922.348541660328;5951.940480595139;5962.19510366095;5970.283565972111;5841.970790146022;5848.444397782204;5859.384764599656;5866.735996880066;5867.119932010232;5746.655200687972;5849.444302791228;5866.178734977021;6009.278886533644;6019.127226552213;5897.233359663216;5901;5903.586748927534;5904.940950590439;5913.881722365442 20:58:59 INFO - 2015-12-29 20:58:59,653 DEBUG : BROWSER_OUTPUT: |1;ext.html;591.4174538079991;616.9850595769956;634.8635043465654;636.8758092172027;651.6676494987557;32617;42821.78589107054;43436.78281608588;43544.782276088656;43577.99999999996;46495.53504464954;46953;47115.29327060097;47181.52818471814;47245.763771181184;8172.223638754309;8287.502749835;8946.642134314636;9071.863922041175;9145.176934075931;10818.404987725671;11069;11075.556977720922;11078.833817492745;11080.224384293102;10704.839427408595;10795.514201860935;10808.243422960395;10816.891831081668;10818.837717434244;10407.219458540601;10482.318649287849;10487.423191724452;10488;10496.265261431703;10544.525496352606;10624.628138015132;10673.83989240162;10696.197785166067;10698.62554810578;43598.34602480965;43999.78000110011;44039.33940990888;44064.339034914185;44087.11825763467;3620.185458271868;3669.4862719219063;3684.5578530576236;3755.75587586806;3788.488554045196;32975.6702432975;32984.6701532984;33142.6685733142;33465.16337091592;33508.83245583781;3678.6321367863266;3740.6259374062647;3765.0963768695588;3904.2581909437117;3911.02224443889;318649;319894;320269;320395.3980230107;321736;60015.69992150011;60853.39146608566;69169.65415172892;69725;70078.64960675164;63971;64285.67857160778;64318;64558;64634.67682661556;17465.825341746673;17958.551036223937;17968.371107011193;17969.550761231072;17973.37093201732;13533.66165845842;13585.456581736818;13611.931940340235;13820.516281930286;13863.237521936391;22415.32754017382;22930.19744308941;22966.54066918652;22970.65544016841;22975.310740677807;8539.615717292736;8739.956300218586;8755.212030917248;8832.64669413229;8944.776380590538;1038.7558923652934;1041.0838462153256;1080.6487891435315;1085.1644233939821;1219.4518405606213;30289.458984998473;30469;30552.388952221274;31204.063878083693;31312;1139.225326777799;1154.3881742676394;1255.976379250926;1259.4634545854044;1260.155695683894;13988.58034258974;15875.52373428799;15981.760273595906;16016.839831601535;16310.592235194215;308016.2995925075;309286;310747;311022;311167;50837.74581127071;51639;54284.728576356865;54496;57742.133867992015;1460.0509668715208;1470.2942587558032;1478.268257212665;1497.213962669607;1584.635533827203;28700;28975.275618109717;29945.70054299429;30468;31300.217494562818;49800;49920.750396247786;50134;50182.749086254335;50264.24603630875;311966;312099;313398;313586;314374;36029.27941441209;36227.27545449129;36599.81700091482;51087.74456127696;51275.743621283145;47663;48085.5191448081;48095.519044810506;48946.51053489562;49138.50861491483;45266.547334526236;45319.32021019753;46399.3040104392;46818.53181468142;47137.05725885394;45195.54804452045;45325.546744532134;46304.30543541917;46547;47089.764551177024;41061.58938410578;41149.588504114574;41215.587844121175;41505.58494415017;41590.58409415867;35891;36223;38905;40599.3910091343;41401.58598414098;26956.865215673795;27380;27509.17472475829;27801;27855.860720696266 20:58:59 INFO - 2015-12-29 20:58:59,653 DEBUG : BROWSER_OUTPUT: |2;jquery.html;380.84195059050495;382.78372719413545;382.96553310202074;386.2468187035281;386.35671606774724;12796;15251.466198683049;17875;20702.68945965812;20773.792262077375;13238.338083095854;13486.730265394686;13563.660908477294;19786.802131978675;19996.30012949547;4804.951950480494;4928.1129396708575;4928.285398617199;4931.161702510564;4933.161362568372;3875.3218186817335;3964.167524819791;4854.17479028566;5284.894302113956;5411.242426060355;5283.260343551887;5287.920681189786;5304.257403963448;5352.91970620441;5362.43694412087;5012.774425150877;5109.718965456898;5126.026055049529;5132.0249152661245;5311.1502159654465;4473.351364052227;4476.820927162909;4487.080148569568;4489.573490518395;4491.9775401123115;15175;15203.543893683207;15417.768733469007;15473.613159670986;15482.458113965957;2190.2224710227956;2212.8451008429415;2245.3825198070663;2333.4516388648653;2355.057976809273;11117.944410277896;11165.330080195134;11263.605773797877;11360.829587556193;11464.025557827596;1847.759791227132;1937.7190307405347;1945.3483083167157;2003.9599208015904;2006.2476571285767;64210.35789642091;69863;70604.29395706029;70935;71880.64059679721;7888.684452621946;7990.880136797953;8069.556174410346;8105.432619716563;8106.189381061965;9611.279154063473;9621.374610650286;9637.084476974676;9643.662471813594;9655.758606034906;6406.199225096863;6477.740890364427;6479.902801457982;6523.641199733966;6524.380183882524;6734.427573656196;6755.054292399068;6766.458683305324;6768.255491895888;6794.76218332356;3675.0996005978704;3723.8510459581853;3726.4596633488536;3754.2303827715255;3761.6990640749223;1241.7951038078616;1260.1305099481328;1274.7450509898058;1304.706441050756;1316.7030474982134;535.5688670620189;551.159481790273;559.4126167524083;578.5024878604397;581.0905932216068;11645.475953582109;13166.210027398387;13215.207087574776;13572.864271357357;13613.387397567134;573.1402895656515;573.5440324941682;580.4311774461052;585.493548080907;598.1804927249609;7087.964560177166;7226.385757210591;7379.520331178456;7402.888956665654;7407.296306850841;622456;626652;645561;646765;658963;78245.60877195577;78884.21115788883;80974;81088;82521.58739206386;606.1180981671657;616.8550390658191;623.5884316351187;623.7536173211556;624.6845343101795;11687.298762074302;11763.882361176278;12097.697557561132;12548.749025019266;12884.742305154032;39009;39389.6061039386;39962.201700922946;40881.79559102185;41176.17647646971;52505.47494525006;54248;55013;55196;55528.72235638796;7628.771136865903;7833;14217.928910355382;14476.927615361856;14645.633859153606;19680.92224276274;21244.681329780375;21404.357869263946;21417.571648567253;21763.23828665989;17278.136093195542;17497.12514374251;17726.379576714753;17760.28958841632;18059;16600.50198494047;16616;16908.23912923946;17243.65512689714;17572.91213543924;12022.939885300868;14558.272086395426;16271.59321016984;16656.750148747535;16869.493915182564;16312.592185195464;16424.75362869534;16453.68370530331;16650.750238746186;16662.50012499627;16502.66994660124;16541.751873722144;16742.665146696756;16891.831081689517;17165.828341716922 20:58:59 INFO - 2015-12-29 20:58:59,653 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1564.1631727026042;1570.9450169244071;1827.7258411238313;1857.025061842532;1864.9254029838808;8142.104368519465;8307.916920830783;8319.33445324374;8319.792005199874;8322.459040162394;8491.065982741893;8537.487750734961;8544.957275213616;8558.914410855905;8559;2447.840890342131;2460.2127319257843;2473.9134130305442;2478.615814548748;2481.1936120760734;2437.0251899240357;2465.6301554766837;2472.221250306157;2473.925782226527;2474.1464194852747;2108.8102070813625;2144.345974477784;2361.114582031738;2459.8401103928277;2473.2951108933958;2353.070537137821;2362.3739708977137;2371.620540713486;2374.560706269337;2375.0499800079933;2409.9156529521383;2466.531359041794;2469.9753002470106;2470.1354525915967;2471.6292556116546;7462.813429664247;7707.421943354215;8307.626156822958;8462;8463.957680211559;4935.679180853269;5023.748812559357;5024.9748751256375;5025.246213068032;5028.547430731252;3410.5054767058887;3416.538767266412;3436.27838153988;3545.0960005198767;3561.216532362876;1128.0862501373913;1137.5790957345753;1143.5540139345662;1148.3167515328366;1153.0314535789894;12021.459034343388;12056.517739290417;12072.698182545419;12084.637460876187;12099.21355111906;4708.505606911293;4732.550407711262;4755.476897541268;4784.473707892129;4786.880327991828;10071.798564028679;10098.141657959155;10099.091081802673;10101.64644237463;10105.090541851268;5267.894642107136;5270.209468579667;5274.156135018456;5276.182191760283;5280.6039547034125;4778.808847646124;4785.856424307276;4790.880227994328;4795.400574928134;4799.160146974265;3891.902702432462;3908.022994251437;3911.7457365271166;3923.136909879879;3942.4086387042175;1306.431702209542;1317.0648839324188;1318.5648735917125;1326.2374134872487;1328.5350127455313;1405.9367328470244;1414.3635364086203;1415.0309724606273;1431.5991522373752;1431.6063082652354;7840.176781437981;7850.332721718603;7875.763727088197;7906.407019473562;7910.7231246906085;517.9896402071937;524.6275144647267;524.6589716684185;527.5963887625969;530.4059453412126;5964.1650168976375;5988.730507127189;6396.584222025554;6452.257990331078;6457.4511166551365;9991.100800927952;10237.641682541076;10271.897281027244;10287.125594324567;10289.2797504174;9930.2055835533;10120.038596333337;10272.280940334254;10302.484875756183;10317.535710893027;7880.842383152305;7902.960485197537;7933.880991785128;7955.681772729142;7966.6415011324625;7763.068431787996;7881.448298619041;7896.802579935547;7898.249666281694;7902.130765615892;9100.954495227747;9182.862257066015;9186.632534698538;9208.815823683623;9225.215856651992;9286.30352723562;9443.858342124737;9453.574589143642;9487.952560237154;9504.239660827256;7401.185869554452;7529.661165247468;7588.886166707393;7668.1181664109345;7674.9232507674205;8319.50082994998;8325.25072743456;8336.87494687568;8385.748427547183;8389.11914248995;7712.5758083305955;7816.53100813953;7878;7934.325582325567;8023.719169829028;7740.109887363025;7781.766547003599;7857.724979625686;7903.525788452711;7961.323287520626;7372;7480.775576732707;7526.924730752622;7529.134149572869;7543.962280188784;7216.242294559206;7251.746188883575;7262.854742905007;7265.382442492236;7268.527545709512;6955.374016338554;6974.267701891228;6993.125859267591;6996.930030699831;6997.685104170223 20:58:59 INFO - 2015-12-29 20:58:59,653 DEBUG : BROWSER_OUTPUT: |4;prototype.html;352.1811787593845;359.28860855506116;362.1092113401034;368.1514109976505;368.41973891121484;5789.942100579004;5872.324682661495;5884.6763428011545;5906.350301466835;5915.083162109869;5717.171010203518;5832.854178645536;5837.387074357195;5842.941570584293;5866.149408335788;4609.516000819916;4627.421572303462;4629.213033784265;4634.536546345355;4635.049814787961;4477.955220447802;4545.36364908913;4553.225951588238;4625.398698169233;4657.836975705851;4578.198815207342;4583.083383323332;4586.312053192015;4595.770211489429;4595.908081838361;4537.523560026183;4578.084383123372;4593.862184134465;4599.264117741145;4602.7008244464005;4090.795460226977;4113.568075352075;4113.732607380511;4119.546849846514;4124.546299907008;5521.254630624854;5620.437956204388;5640.238567793377;5650.491455768959;5688.97155514224;5389.703566303851;5393.029254734146;5393.487618676219;5395.622306438551;5397.379301380352;6002.429769171922;6263.342349053375;6268.686565671698;6269.905951410732;6270.6864656766975;4424.867253982354;4529.750863702495;4569.95430045702;4579.67942244043;4584.793684284182;6275.717592708339;6323.20959880015;6368.172137622126;6371.553991220663;6386.68066596673;4646.186917289461;4670.789814458358;4678.1813182692895;4681.368015317957;4682.836100736526;4690.132325519721;4706.905861882743;4746.5728084471875;4788.545088216614;4796.064767370399;5354.223637572531;5370.946290537123;5374.435684253097;5374.48942350476;5374.677519348852;6245.375462453719;6245.812625621148;6252.406021427957;6255.12428260044;6257.061440783918;1719.1576127697338;1740.1473278093897;1740.6779745746824;1740.825917408249;1741.1555395633109;1179.9705007374712;1200.9971673652424;1203.8916497515265;1214.4231490042337;1231.6058861164342;5993.370696076936;5999.370066143079;6002.939970600238;6005.249343832021;6005.909911351333;6330.651814150174;6341.429271365507;6346.30190679025;6347.492200624031;6357.760236753881;5879.147523609053;5975.19334889793;5989.580729348903;5990.371011043778;5993.280806303272;3525.6474352564537;3540.592831824373;3549.8757543485854;3553.2893421315325;3555.253396786704;6593.670316484253;6647.833804154935;6654.50091243149;6654.500912431587;6664.233613134552;6567.934320656828;6574.474042076622;6578.901316480256;6579.342065793382;6580.144581204413;6508.9023664645065;6629;6637.037629543689;6645.136132302867;6648.867022659423;6239.656818875005;6307.968460157854;6326.778562750282;6420.165378500765;6431.485481161402;6329.145565348619;6330.936690633219;6338.397852204033;6341.968290158704;6346.1432706585865;6598.274189839018;6604.537682362381;6608.966955165386;6612.4710023198995;6615.669216539058;4564.950061485811;4625.560571745679;4630.83792067276;4635.351050852816;4667.836625718083;6419.935800642121;6423.357664233539;6434.517411194086;6517.217933847968;6523;6336.619802811846;6344.71448784815;6346.365363463617;6350.206224221973;6351.333110023381;6217.595856269328;6299.811005669837;6325.209348831396;6331.556791024584;6339.207599050119;6192.535559832941;6196.411340922605;6196.938030619636;6198.938010619836;6206.038064100072;6327.905081423874;6334.841628959313;6339.429451349401;6340.080688300079;6345.682715864096;6106.816795496142;6185.969070154621;6200;6209.720562574605;6210.813675589739 20:58:59 INFO - 2015-12-29 20:58:59,654 DEBUG : BROWSER_OUTPUT: |5;yui.html;821.8931538899942;850.2815121222567;900.7973206028645;967.463058002809;978.1050338939871;14267.143971361713;14524.419023239085;14583.052101613388;14617.853821461782;14638;13535.864641353584;13637.590872273822;13640;13643.590692279222;13661.590152295423;764.5565571968245;767.87330090535;886.3972498700881;912.0286894457381;917.312015988009;909.0682050897816;912.0560220172123;912.192709452133;918.2103391083696;918.3984490158956;799.5922079739346;950.5769932380093;963.291980394413;963.6386355116831;966.038791402552;788.8501184774904;955.8470644696849;960.342165616548;964.4502633498909;965.3725078698832;719.0472623773521;720.2113685514354;725.4124159430878;725.9201487836334;726.1504040272894;14234.288285585782;14364.497242596459;14412.063215890934;14437;14437.278136093153;13622.93188534051;14003.019788614802;14042;14129.646758831112;14324.283785810772;10431;10795.946020269927;10860.076893464066;11037;11051.392173430459;3864.087276798003;3894.883153505399;3908.4918960535233;3942.3889297158985;3969.6030396960364;54727.17909231365;54985.1752223717;55003.32471739867;55071.449285507435;55913;9648.324617276863;9848.162906152915;9966.750831229132;9985;9986.550605222783;19125.713114303297;19131.521711957314;19153.425397238105;19159.425217243504;19182;8187.26314631686;8478.94013248344;8529.74410767678;8666.78333041679;8669;4765.8570242892765;4911.287863259879;4971.2543118531785;4986.526280003394;5025.14572522672;3242.5946756655417;3281.3273278977754;3289.8190599517256;3376.18971446851;3422.7261819054415;540.4595404595404;545.1087471983336;546.0880329849082;548.0600769680018;554.7614525753964;615.3139249736512;655.7180412422608;695.8886578147473;708.3624737736079;715.492000679513;8515;8823.205911467998;8829.304759531522;8877;8914.86627700585;450.82192533948904;558.3774091887598;693.549193024528;694.5520139510089;705.9788206353818;4388.29787234041;4407.537208593116;4534.501204867462;4568.314752787109;4594.908101837945;64545;65140;65388.67305663441;68538.65730671414;68903.65548172226;53907;54387.45612543903;54494.45505544973;56140.75413997458;56911.71544142336;55570.72214638982;55780.442195577525;56316;56343.71828140833;57290.713546432;9345.719628411158;9388.155066044088;9676.177524910461;9789.167920726533;9806.362586431858;41271.380929286686;41423;41598;42136.57863421449;42519.57480425156;48708;53006.4699353017;53409;53688.73155634353;54270.45729542812;8986.415882967585;9350.579223934803;9363.485008324607;9375.85936210971;9382.343235973416;13530.594082177551;13546.93226533861;13913;13983.44066237339;14076.577702668936;11679.416029198675;11971.700707482383;12102.878971210175;12136.878631213574;12173.513059477877;12359.443825027716;12530.749385012066;12631.242125472501;12845.935770321088;13172.868271317548;11782.088082102604;11881.346525940811;11989.460474278852;12263.75472490563;12499.625011249676;10798.73003174927;11164.888351116384;11239.831402529133;11321.433928303717;11341.036011939077;10267.691969240936;10414.427206503715;10415.1667866572;10602;10603.416812075102 20:58:59 INFO - 2015-12-29 20:58:59,654 DEBUG : BROWSER_OUTPUT: __end_tp_report 20:58:59 INFO - 2015-12-29 20:58:59,654 DEBUG : BROWSER_OUTPUT: __start_cc_report 20:58:59 INFO - 2015-12-29 20:58:59,655 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,814 20:58:59 INFO - 2015-12-29 20:58:59,655 DEBUG : BROWSER_OUTPUT: __end_cc_report 20:58:59 INFO - 2015-12-29 20:58:59,655 DEBUG : BROWSER_OUTPUT: __startTimestamp1451451539645__endTimestamp 20:58:59 INFO - 2015-12-29 20:58:59,655 DEBUG : BROWSER_OUTPUT: 20:58:59 INFO - 2015-12-29 20:58:59,655 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 20:58:59 INFO - 2015-12-29 20:58:59,655 DEBUG : BROWSER_OUTPUT: Number of tests: 6 20:58:59 INFO - 2015-12-29 20:58:59,655 DEBUG : BROWSER_OUTPUT: 20:58:59 INFO - 2015-12-29 20:58:59,655 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5629.67 Median:5852.77 stddev:627.46 (10.7%) stddev-sans-first:602.38 20:58:59 INFO - 2015-12-29 20:58:59,655 DEBUG : BROWSER_OUTPUT: Values: 3308.6 3389.6 3419.7 3420.0 3456.8 5594.1 5640.3 5670.6 5675.9 5677.5 5637.1 5644.8 5656.0 5666.5 5701.2 4958.2 5154.9 5170.1 5242.0 5253.6 5098.3 5108.3 5131.9 5135.9 5137.0 5053.3 5067.9 5172.0 5179.8 5181.0 5157.5 5158.3 5166.5 5166.7 5170.2 5091.9 5136.8 5196.9 5201.3 5275.1 5205.8 5289.7 5314.0 5406.6 5430.2 6059.7 6138.1 6159.7 6161.5 6179.2 5850.7 6212.8 6217.6 6222.9 6230.9 5598.8 5607.7 5729.5 5734.1 5764.7 6167.6 6185.8 6194.1 6196.8 6196.9 5733.3 5841.8 6003.5 6031.7 6035.8 5919.2 6055.3 6065.1 6067.9 6087.9 6041.3 6086.4 6088.1 6092.8 6096.3 5845.2 5951.5 5992.6 6045.2 6073.7 4554.9 4599.7 4602.6 4642.6 4661.8 4179.3 4216.7 4229.7 4232.4 4247.8 5563.9 5802.2 5856.5 5863.0 5865.3 5948.3 5974.0 6035.1 6040.4 6067.0 5680.6 5694.5 5697.7 5697.8 5700.6 5078.5 5190.8 5272.2 5298.0 5309.2 6184.4 6279.4 6306.2 6313.9 6314.1 6030.8 6113.1 6118.1 6119.6 6122.7 6105.8 6139.0 6212.1 6310.6 6333.1 6037.7 6039.3 6039.9 6045.0 6048.2 6132.3 6137.8 6141.6 6144.0 6144.3 5685.3 5763.0 5852.8 5978.4 5979.1 5884.8 5922.3 5951.9 5962.2 5970.3 5842.0 5848.4 5859.4 5866.7 5867.1 5746.7 5849.4 5866.2 6009.3 6019.1 5897.2 5901.0 5903.6 5904.9 5913.9 20:58:59 INFO - 2015-12-29 20:58:59,655 DEBUG : BROWSER_OUTPUT: 20:58:59 INFO - 2015-12-29 20:58:59,655 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:51006.35 Median:34699.92 stddev:81886.77 (236.0%) stddev-sans-first:82028.99 20:58:59 INFO - 2015-12-29 20:58:59,657 DEBUG : BROWSER_OUTPUT: Values: 591.4 617.0 634.9 636.9 651.7 32617.0 42821.8 43436.8 43544.8 43578.0 46495.5 46953.0 47115.3 47181.5 47245.8 8172.2 8287.5 8946.6 9071.9 9145.2 10818.4 11069.0 11075.6 11078.8 11080.2 10704.8 10795.5 10808.2 10816.9 10818.8 10407.2 10482.3 10487.4 10488.0 10496.3 10544.5 10624.6 10673.8 10696.2 10698.6 43598.3 43999.8 44039.3 44064.3 44087.1 3620.2 3669.5 3684.6 3755.8 3788.5 32975.7 32984.7 33142.7 33465.2 33508.8 3678.6 3740.6 3765.1 3904.3 3911.0 318649.0 319894.0 320269.0 320395.4 321736.0 60015.7 60853.4 69169.7 69725.0 70078.6 63971.0 64285.7 64318.0 64558.0 64634.7 17465.8 17958.6 17968.4 17969.6 17973.4 13533.7 13585.5 13611.9 13820.5 13863.2 22415.3 22930.2 22966.5 22970.7 22975.3 8539.6 8740.0 8755.2 8832.6 8944.8 1038.8 1041.1 1080.6 1085.2 1219.5 30289.5 30469.0 30552.4 31204.1 31312.0 1139.2 1154.4 1256.0 1259.5 1260.2 13988.6 15875.5 15981.8 16016.8 16310.6 308016.3 309286.0 310747.0 311022.0 311167.0 50837.7 51639.0 54284.7 54496.0 57742.1 1460.1 1470.3 1478.3 1497.2 1584.6 28700.0 28975.3 29945.7 30468.0 31300.2 49800.0 49920.8 50134.0 50182.7 50264.2 311966.0 312099.0 313398.0 313586.0 314374.0 36029.3 36227.3 36599.8 51087.7 51275.7 47663.0 48085.5 48095.5 48946.5 49138.5 45266.5 45319.3 46399.3 46818.5 47137.1 45195.5 45325.5 46304.3 46547.0 47089.8 41061.6 41149.6 41215.6 41505.6 41590.6 35891.0 36223.0 38905.0 40599.4 41401.6 26956.9 27380.0 27509.2 27801.0 27855.9 20:58:59 INFO - 2015-12-29 20:58:59,657 DEBUG : BROWSER_OUTPUT: 20:58:59 INFO - 2015-12-29 20:58:59,657 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:32222.98 Median:21676.89 stddev:104650.98 (482.8%) stddev-sans-first:104917.23 20:58:59 INFO - 2015-12-29 20:58:59,657 DEBUG : BROWSER_OUTPUT: Values: 380.8 382.8 383.0 386.2 386.4 12796.0 15251.5 17875.0 20702.7 20773.8 13238.3 13486.7 13563.7 19786.8 19996.3 4805.0 4928.1 4928.3 4931.2 4933.2 3875.3 3964.2 4854.2 5284.9 5411.2 5283.3 5287.9 5304.3 5352.9 5362.4 5012.8 5109.7 5126.0 5132.0 5311.2 4473.4 4476.8 4487.1 4489.6 4492.0 15175.0 15203.5 15417.8 15473.6 15482.5 2190.2 2212.8 2245.4 2333.5 2355.1 11117.9 11165.3 11263.6 11360.8 11464.0 1847.8 1937.7 1945.3 2004.0 2006.2 64210.4 69863.0 70604.3 70935.0 71880.6 7888.7 7990.9 8069.6 8105.4 8106.2 9611.3 9621.4 9637.1 9643.7 9655.8 6406.2 6477.7 6479.9 6523.6 6524.4 6734.4 6755.1 6766.5 6768.3 6794.8 3675.1 3723.9 3726.5 3754.2 3761.7 1241.8 1260.1 1274.7 1304.7 1316.7 535.6 551.2 559.4 578.5 581.1 11645.5 13166.2 13215.2 13572.9 13613.4 573.1 573.5 580.4 585.5 598.2 7088.0 7226.4 7379.5 7402.9 7407.3 622456.0 626652.0 645561.0 646765.0 658963.0 78245.6 78884.2 80974.0 81088.0 82521.6 606.1 616.9 623.6 623.8 624.7 11687.3 11763.9 12097.7 12548.7 12884.7 39009.0 39389.6 39962.2 40881.8 41176.2 52505.5 54248.0 55013.0 55196.0 55528.7 7628.8 7833.0 14217.9 14476.9 14645.6 19680.9 21244.7 21404.4 21417.6 21763.2 17278.1 17497.1 17726.4 17760.3 18059.0 16600.5 16616.0 16908.2 17243.7 17572.9 12022.9 14558.3 16271.6 16656.8 16869.5 16312.6 16424.8 16453.7 16650.8 16662.5 16502.7 16541.8 16742.7 16891.8 17165.8 20:58:59 INFO - 2015-12-29 20:58:59,657 DEBUG : BROWSER_OUTPUT: 20:58:59 INFO - 2015-12-29 20:58:59,658 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5966.84 Median:2896.28 stddev:3134.87 (108.2%) stddev-sans-first:3126.20 20:58:59 INFO - 2015-12-29 20:58:59,659 DEBUG : BROWSER_OUTPUT: Values: 1564.2 1570.9 1827.7 1857.0 1864.9 8142.1 8307.9 8319.3 8319.8 8322.5 8491.1 8537.5 8545.0 8558.9 8559.0 2447.8 2460.2 2473.9 2478.6 2481.2 2437.0 2465.6 2472.2 2473.9 2474.1 2108.8 2144.3 2361.1 2459.8 2473.3 2353.1 2362.4 2371.6 2374.6 2375.0 2409.9 2466.5 2470.0 2470.1 2471.6 7462.8 7707.4 8307.6 8462.0 8464.0 4935.7 5023.7 5025.0 5025.2 5028.5 3410.5 3416.5 3436.3 3545.1 3561.2 1128.1 1137.6 1143.6 1148.3 1153.0 12021.5 12056.5 12072.7 12084.6 12099.2 4708.5 4732.6 4755.5 4784.5 4786.9 10071.8 10098.1 10099.1 10101.6 10105.1 5267.9 5270.2 5274.2 5276.2 5280.6 4778.8 4785.9 4790.9 4795.4 4799.2 3891.9 3908.0 3911.7 3923.1 3942.4 1306.4 1317.1 1318.6 1326.2 1328.5 1405.9 1414.4 1415.0 1431.6 1431.6 7840.2 7850.3 7875.8 7906.4 7910.7 518.0 524.6 524.7 527.6 530.4 5964.2 5988.7 6396.6 6452.3 6457.5 9991.1 10237.6 10271.9 10287.1 10289.3 9930.2 10120.0 10272.3 10302.5 10317.5 7880.8 7903.0 7933.9 7955.7 7966.6 7763.1 7881.4 7896.8 7898.2 7902.1 9101.0 9182.9 9186.6 9208.8 9225.2 9286.3 9443.9 9453.6 9488.0 9504.2 7401.2 7529.7 7588.9 7668.1 7674.9 8319.5 8325.3 8336.9 8385.7 8389.1 7712.6 7816.5 7878.0 7934.3 8023.7 7740.1 7781.8 7857.7 7903.5 7961.3 7372.0 7480.8 7526.9 7529.1 7544.0 7216.2 7251.7 7262.9 7265.4 7268.5 6955.4 6974.3 6993.1 6996.9 6997.7 20:58:59 INFO - 2015-12-29 20:58:59,659 DEBUG : BROWSER_OUTPUT: 20:58:59 INFO - 2015-12-29 20:58:59,659 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5279.70 Median:5945.14 stddev:1521.19 (25.6%) stddev-sans-first:1479.81 20:58:59 INFO - 2015-12-29 20:58:59,659 DEBUG : BROWSER_OUTPUT: Values: 352.2 359.3 362.1 368.2 368.4 5789.9 5872.3 5884.7 5906.4 5915.1 5717.2 5832.9 5837.4 5842.9 5866.1 4609.5 4627.4 4629.2 4634.5 4635.0 4478.0 4545.4 4553.2 4625.4 4657.8 4578.2 4583.1 4586.3 4595.8 4595.9 4537.5 4578.1 4593.9 4599.3 4602.7 4090.8 4113.6 4113.7 4119.5 4124.5 5521.3 5620.4 5640.2 5650.5 5689.0 5389.7 5393.0 5393.5 5395.6 5397.4 6002.4 6263.3 6268.7 6269.9 6270.7 4424.9 4529.8 4570.0 4579.7 4584.8 6275.7 6323.2 6368.2 6371.6 6386.7 4646.2 4670.8 4678.2 4681.4 4682.8 4690.1 4706.9 4746.6 4788.5 4796.1 5354.2 5370.9 5374.4 5374.5 5374.7 6245.4 6245.8 6252.4 6255.1 6257.1 1719.2 1740.1 1740.7 1740.8 1741.2 1180.0 1201.0 1203.9 1214.4 1231.6 5993.4 5999.4 6002.9 6005.2 6005.9 6330.7 6341.4 6346.3 6347.5 6357.8 5879.1 5975.2 5989.6 5990.4 5993.3 3525.6 3540.6 3549.9 3553.3 3555.3 6593.7 6647.8 6654.5 6654.5 6664.2 6567.9 6574.5 6578.9 6579.3 6580.1 6508.9 6629.0 6637.0 6645.1 6648.9 6239.7 6308.0 6326.8 6420.2 6431.5 6329.1 6330.9 6338.4 6342.0 6346.1 6598.3 6604.5 6609.0 6612.5 6615.7 4565.0 4625.6 4630.8 4635.4 4667.8 6419.9 6423.4 6434.5 6517.2 6523.0 6336.6 6344.7 6346.4 6350.2 6351.3 6217.6 6299.8 6325.2 6331.6 6339.2 6192.5 6196.4 6196.9 6198.9 6206.0 6327.9 6334.8 6339.4 6340.1 6345.7 6106.8 6186.0 6200.0 6209.7 6210.8 20:58:59 INFO - 2015-12-29 20:58:59,659 DEBUG : BROWSER_OUTPUT: 20:58:59 INFO - 2015-12-29 20:58:59,659 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:15447.28 Median:27223.73 stddev:18513.20 (68.0%) stddev-sans-first:18532.56 20:58:59 INFO - 2015-12-29 20:58:59,659 DEBUG : BROWSER_OUTPUT: Values: 821.9 850.3 900.8 967.5 978.1 14267.1 14524.4 14583.1 14617.9 14638.0 13535.9 13637.6 13640.0 13643.6 13661.6 764.6 767.9 886.4 912.0 917.3 909.1 912.1 912.2 918.2 918.4 799.6 950.6 963.3 963.6 966.0 788.9 955.8 960.3 964.5 965.4 719.0 720.2 725.4 725.9 726.2 14234.3 14364.5 14412.1 14437.0 14437.3 13622.9 14003.0 14042.0 14129.6 14324.3 10431.0 10795.9 10860.1 11037.0 11051.4 3864.1 3894.9 3908.5 3942.4 3969.6 54727.2 54985.2 55003.3 55071.4 55913.0 9648.3 9848.2 9966.8 9985.0 9986.6 19125.7 19131.5 19153.4 19159.4 19182.0 8187.3 8478.9 8529.7 8666.8 8669.0 4765.9 4911.3 4971.3 4986.5 5025.1 3242.6 3281.3 3289.8 3376.2 3422.7 540.5 545.1 546.1 548.1 554.8 615.3 655.7 695.9 708.4 715.5 8515.0 8823.2 8829.3 8877.0 8914.9 450.8 558.4 693.5 694.6 706.0 4388.3 4407.5 4534.5 4568.3 4594.9 64545.0 65140.0 65388.7 68538.7 68903.7 53907.0 54387.5 54494.5 56140.8 56911.7 55570.7 55780.4 56316.0 56343.7 57290.7 9345.7 9388.2 9676.2 9789.2 9806.4 41271.4 41423.0 41598.0 42136.6 42519.6 48708.0 53006.5 53409.0 53688.7 54270.5 8986.4 9350.6 9363.5 9375.9 9382.3 13530.6 13546.9 13913.0 13983.4 14076.6 11679.4 11971.7 12102.9 12136.9 12173.5 12359.4 12530.7 12631.2 12845.9 13172.9 11782.1 11881.3 11989.5 12263.8 12499.6 10798.7 11164.9 11239.8 11321.4 11341.0 10267.7 10414.4 10415.2 10602.0 10603.4 20:58:59 INFO - 2015-12-29 20:58:59,659 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 20:58:59 INFO - 2015-12-29 20:58:59,659 DEBUG : BROWSER_OUTPUT: 20:59:00 INFO - 2015-12-29 20:59:00,238 INFO : Browser exited with error code: 0 20:59:00 INFO - 2015-12-29 20:59:00,256 INFO : Completed test dromaeo_css (00:18:29) 20:59:00 INFO - 2015-12-29 20:59:00,257 INFO : Starting test kraken 20:59:00 INFO - 2015-12-29 20:59:00,257 DEBUG : operating with platform_type : linux_ 20:59:00 INFO - 2015-12-29 20:59:00,257 INFO : Initialising browser for kraken test... 20:59:00 INFO - 2015-12-29 20:59:00,263 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpTwB7Wp/profile http://localhost:54114/getInfo.html 20:59:03 INFO - 2015-12-29 20:59:03,863 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 20:59:03 INFO - 2015-12-29 20:59:03,863 DEBUG : BROWSER_OUTPUT: colorDepth:24 20:59:03 INFO - 2015-12-29 20:59:03,863 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 20:59:03 INFO - 2015-12-29 20:59:03,863 DEBUG : BROWSER_OUTPUT: __metrics 20:59:03 INFO - 2015-12-29 20:59:03,964 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:59:05 INFO - 2015-12-29 20:59:05,222 INFO : Browser initialized. 20:59:05 INFO - 2015-12-29 20:59:05,223 INFO : Running cycle 1/1 for kraken test... 20:59:05 INFO - 2015-12-29 20:59:05,223 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpTwB7Wp/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 20:59:16 INFO - 2015-12-29 20:59:16,798 DEBUG : BROWSER_OUTPUT: RSS: Main: 128847872 20:59:16 INFO - 2015-12-29 20:59:16,798 DEBUG : BROWSER_OUTPUT: 20:59:19 INFO - 2015-12-29 20:59:19,234 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54114/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54114/tests/kraken/driver.html?testName=audio-beat-detection) 20:59:19 INFO - 2015-12-29 20:59:19,800 DEBUG : BROWSER_OUTPUT: RSS: Main: 165335040 20:59:19 INFO - 2015-12-29 20:59:19,800 DEBUG : BROWSER_OUTPUT: 20:59:22 INFO - 2015-12-29 20:59:22,330 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54114/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54114/tests/kraken/driver.html?testName=audio-dft) 20:59:22 INFO - 2015-12-29 20:59:22,896 DEBUG : BROWSER_OUTPUT: RSS: Main: 162496512 20:59:22 INFO - 2015-12-29 20:59:22,896 DEBUG : BROWSER_OUTPUT: 20:59:25 INFO - 2015-12-29 20:59:25,672 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54114/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54114/tests/kraken/driver.html?testName=audio-fft) 20:59:26 INFO - 2015-12-29 20:59:26,233 DEBUG : BROWSER_OUTPUT: RSS: Main: 159342592 20:59:26 INFO - 2015-12-29 20:59:26,233 DEBUG : BROWSER_OUTPUT: 20:59:28 INFO - 2015-12-29 20:59:28,234 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54114/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54114/tests/kraken/driver.html?testName=audio-oscillator) 20:59:28 INFO - 2015-12-29 20:59:28,800 DEBUG : BROWSER_OUTPUT: RSS: Main: 158478336 20:59:28 INFO - 2015-12-29 20:59:28,800 DEBUG : BROWSER_OUTPUT: 20:59:30 INFO - 2015-12-29 20:59:30,926 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54114/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54114/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:59:31 INFO - 2015-12-29 20:59:31,493 DEBUG : BROWSER_OUTPUT: RSS: Main: 156745728 20:59:31 INFO - 2015-12-29 20:59:31,493 DEBUG : BROWSER_OUTPUT: 20:59:34 INFO - 2015-12-29 20:59:34,372 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54114/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54114/tests/kraken/driver.html?testName=imaging-darkroom) 20:59:34 INFO - 2015-12-29 20:59:34,938 DEBUG : BROWSER_OUTPUT: RSS: Main: 156336128 20:59:34 INFO - 2015-12-29 20:59:34,939 DEBUG : BROWSER_OUTPUT: 20:59:38 INFO - 2015-12-29 20:59:38,280 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54114/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54114/tests/kraken/driver.html?testName=imaging-desaturate) 20:59:38 INFO - 2015-12-29 20:59:38,854 DEBUG : BROWSER_OUTPUT: RSS: Main: 157343744 20:59:38 INFO - 2015-12-29 20:59:38,854 DEBUG : BROWSER_OUTPUT: 20:59:41 INFO - 2015-12-29 20:59:41,572 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54114/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54114/tests/kraken/driver.html?testName=json-parse-financial) 20:59:42 INFO - 2015-12-29 20:59:42,139 DEBUG : BROWSER_OUTPUT: RSS: Main: 156966912 20:59:42 INFO - 2015-12-29 20:59:42,139 DEBUG : BROWSER_OUTPUT: 20:59:43 INFO - 2015-12-29 20:59:43,649 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54114/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54114/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:59:44 INFO - 2015-12-29 20:59:44,203 DEBUG : BROWSER_OUTPUT: RSS: Main: 161193984 20:59:44 INFO - 2015-12-29 20:59:44,203 DEBUG : BROWSER_OUTPUT: 20:59:45 INFO - 2015-12-29 20:59:45,933 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54114/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54114/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:59:46 INFO - 2015-12-29 20:59:46,519 DEBUG : BROWSER_OUTPUT: RSS: Main: 159678464 20:59:46 INFO - 2015-12-29 20:59:46,519 DEBUG : BROWSER_OUTPUT: 20:59:48 INFO - 2015-12-29 20:59:48,450 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54114/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54114/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:59:49 INFO - 2015-12-29 20:59:49,016 DEBUG : BROWSER_OUTPUT: RSS: Main: 164110336 20:59:49 INFO - 2015-12-29 20:59:49,016 DEBUG : BROWSER_OUTPUT: 20:59:51 INFO - 2015-12-29 20:59:51,333 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54114/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54114/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:59:51 INFO - 2015-12-29 20:59:51,902 DEBUG : BROWSER_OUTPUT: RSS: Main: 170766336 20:59:51 INFO - 2015-12-29 20:59:51,902 DEBUG : BROWSER_OUTPUT: 20:59:54 INFO - 2015-12-29 20:59:54,317 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54114/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54114/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:59:54 INFO - 2015-12-29 20:59:54,883 DEBUG : BROWSER_OUTPUT: RSS: Main: 166653952 20:59:54 INFO - 2015-12-29 20:59:54,883 DEBUG : BROWSER_OUTPUT: 20:59:56 INFO - 2015-12-29 20:59:56,500 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54114/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54114/tests/kraken/driver.html?testName=ai-astar) 20:59:56 INFO - 2015-12-29 20:59:56,751 DEBUG : BROWSER_OUTPUT: RSS: Main: 225767424 20:59:56 INFO - 2015-12-29 20:59:56,751 DEBUG : BROWSER_OUTPUT: 20:59:56 INFO - 2015-12-29 20:59:56,752 DEBUG : BROWSER_OUTPUT: __start_tp_report 20:59:56 INFO - 2015-12-29 20:59:56,752 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 20:59:56 INFO - 2015-12-29 20:59:56,753 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 20:59:56 INFO - 2015-12-29 20:59:56,753 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 20:59:56 INFO - 2015-12-29 20:59:56,753 DEBUG : BROWSER_OUTPUT: |0;ai-astar;107;110;104;109;109;110;101;109;108;108 20:59:56 INFO - 2015-12-29 20:59:56,753 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;147;127;144;156;128;148;147;123;168;124 20:59:56 INFO - 2015-12-29 20:59:56,753 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;160;162;162;161;162;162;164;160;160 20:59:56 INFO - 2015-12-29 20:59:56,754 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;72;161;71;79;71;71;148;73 20:59:56 INFO - 2015-12-29 20:59:56,754 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;89;89;134;90;89;89;131;89;89;130 20:59:56 INFO - 2015-12-29 20:59:56,754 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;110;109;110;109;109;109;109;110 20:59:56 INFO - 2015-12-29 20:59:56,754 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;145;146;146;146;146;144;145;145;146 20:59:56 INFO - 2015-12-29 20:59:56,754 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;96;95;95;96;95;95;95 20:59:56 INFO - 2015-12-29 20:59:56,755 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;55;54;56;54;54;54;54;55;52;53 20:59:56 INFO - 2015-12-29 20:59:56,755 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;63;64;63;63;63;64;63;64;64;62 20:59:56 INFO - 2015-12-29 20:59:56,755 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;77;77;77;78;78;80;79;78;79;78 20:59:56 INFO - 2015-12-29 20:59:56,755 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;115;114;110;110;115;120;117;112;110;114 20:59:56 INFO - 2015-12-29 20:59:56,755 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;126;135;134;135;135;140;135;137;142;135 20:59:56 INFO - 2015-12-29 20:59:56,755 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;61;61;61;62;63;62;63;61;69 20:59:56 INFO - 2015-12-29 20:59:56,755 DEBUG : BROWSER_OUTPUT: __end_tp_report 20:59:56 INFO - 2015-12-29 20:59:56,756 DEBUG : BROWSER_OUTPUT: __start_cc_report 20:59:56 INFO - 2015-12-29 20:59:56,756 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,869 20:59:56 INFO - 2015-12-29 20:59:56,756 DEBUG : BROWSER_OUTPUT: __end_cc_report 20:59:56 INFO - 2015-12-29 20:59:56,756 DEBUG : BROWSER_OUTPUT: __startTimestamp1451451596751__endTimestamp 20:59:56 INFO - 2015-12-29 20:59:56,756 DEBUG : BROWSER_OUTPUT: 20:59:56 INFO - 2015-12-29 20:59:56,760 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 20:59:56 INFO - 2015-12-29 20:59:56,760 DEBUG : BROWSER_OUTPUT: Number of tests: 14 20:59:56 INFO - 2015-12-29 20:59:56,760 DEBUG : BROWSER_OUTPUT: 20:59:56 INFO - 2015-12-29 20:59:56,760 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.50 Median:109.00 stddev:2.88 (2.6%) stddev-sans-first:3.05 20:59:56 INFO - 2015-12-29 20:59:56,760 DEBUG : BROWSER_OUTPUT: Values: 107.0 110.0 104.0 109.0 109.0 110.0 101.0 109.0 108.0 108.0 20:59:56 INFO - 2015-12-29 20:59:56,760 DEBUG : BROWSER_OUTPUT: 20:59:56 INFO - 2015-12-29 20:59:56,760 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:141.20 Median:147.00 stddev:15.13 (10.3%) stddev-sans-first:15.91 20:59:56 INFO - 2015-12-29 20:59:56,760 DEBUG : BROWSER_OUTPUT: Values: 147.0 127.0 144.0 156.0 128.0 148.0 147.0 123.0 168.0 124.0 20:59:56 INFO - 2015-12-29 20:59:56,760 DEBUG : BROWSER_OUTPUT: 20:59:56 INFO - 2015-12-29 20:59:56,760 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.40 Median:162.00 stddev:1.26 (0.8%) stddev-sans-first:1.33 20:59:56 INFO - 2015-12-29 20:59:56,760 DEBUG : BROWSER_OUTPUT: Values: 161.0 160.0 162.0 162.0 161.0 162.0 162.0 164.0 160.0 160.0 20:59:56 INFO - 2015-12-29 20:59:56,760 DEBUG : BROWSER_OUTPUT: 20:59:56 INFO - 2015-12-29 20:59:56,760 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:89.00 Median:72.00 stddev:34.74 (48.2%) stddev-sans-first:36.30 20:59:56 INFO - 2015-12-29 20:59:56,760 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 72.0 161.0 71.0 79.0 71.0 71.0 148.0 73.0 20:59:56 INFO - 2015-12-29 20:59:56,760 DEBUG : BROWSER_OUTPUT: 20:59:56 INFO - 2015-12-29 20:59:56,761 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:101.90 Median:89.00 stddev:20.57 (23.1%) stddev-sans-first:21.28 20:59:56 INFO - 2015-12-29 20:59:56,761 DEBUG : BROWSER_OUTPUT: Values: 89.0 89.0 134.0 90.0 89.0 89.0 131.0 89.0 89.0 130.0 20:59:56 INFO - 2015-12-29 20:59:56,761 DEBUG : BROWSER_OUTPUT: 20:59:56 INFO - 2015-12-29 20:59:56,761 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 20:59:56 INFO - 2015-12-29 20:59:56,761 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 110.0 109.0 110.0 109.0 109.0 109.0 109.0 110.0 20:59:56 INFO - 2015-12-29 20:59:56,761 DEBUG : BROWSER_OUTPUT: 20:59:56 INFO - 2015-12-29 20:59:56,761 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.71 (0.5%) stddev-sans-first:0.73 20:59:56 INFO - 2015-12-29 20:59:56,761 DEBUG : BROWSER_OUTPUT: Values: 146.0 145.0 146.0 146.0 146.0 146.0 144.0 145.0 145.0 146.0 20:59:56 INFO - 2015-12-29 20:59:56,761 DEBUG : BROWSER_OUTPUT: 20:59:56 INFO - 2015-12-29 20:59:56,761 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 20:59:56 INFO - 2015-12-29 20:59:56,761 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 96.0 95.0 95.0 96.0 95.0 95.0 95.0 20:59:56 INFO - 2015-12-29 20:59:56,761 DEBUG : BROWSER_OUTPUT: 20:59:56 INFO - 2015-12-29 20:59:56,761 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:54.10 Median:54.00 stddev:1.10 (2.0%) stddev-sans-first:1.12 20:59:56 INFO - 2015-12-29 20:59:56,761 DEBUG : BROWSER_OUTPUT: Values: 55.0 54.0 56.0 54.0 54.0 54.0 54.0 55.0 52.0 53.0 20:59:56 INFO - 2015-12-29 20:59:56,761 DEBUG : BROWSER_OUTPUT: 20:59:56 INFO - 2015-12-29 20:59:56,761 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:63.30 Median:63.50 stddev:0.67 (1.1%) stddev-sans-first:0.71 20:59:56 INFO - 2015-12-29 20:59:56,762 DEBUG : BROWSER_OUTPUT: Values: 63.0 64.0 63.0 63.0 63.0 64.0 63.0 64.0 64.0 62.0 20:59:56 INFO - 2015-12-29 20:59:56,762 DEBUG : BROWSER_OUTPUT: 20:59:56 INFO - 2015-12-29 20:59:56,762 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:78.10 Median:78.00 stddev:0.99 (1.3%) stddev-sans-first:0.97 20:59:56 INFO - 2015-12-29 20:59:56,762 DEBUG : BROWSER_OUTPUT: Values: 77.0 77.0 77.0 78.0 78.0 80.0 79.0 78.0 79.0 78.0 20:59:56 INFO - 2015-12-29 20:59:56,762 DEBUG : BROWSER_OUTPUT: 20:59:56 INFO - 2015-12-29 20:59:56,762 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:113.70 Median:114.50 stddev:3.30 (2.9%) stddev-sans-first:3.47 20:59:56 INFO - 2015-12-29 20:59:56,762 DEBUG : BROWSER_OUTPUT: Values: 115.0 114.0 110.0 110.0 115.0 120.0 117.0 112.0 110.0 114.0 20:59:56 INFO - 2015-12-29 20:59:56,762 DEBUG : BROWSER_OUTPUT: 20:59:56 INFO - 2015-12-29 20:59:56,762 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:135.40 Median:135.00 stddev:4.20 (3.1%) stddev-sans-first:2.74 20:59:56 INFO - 2015-12-29 20:59:56,762 DEBUG : BROWSER_OUTPUT: Values: 126.0 135.0 134.0 135.0 135.0 140.0 135.0 137.0 142.0 135.0 20:59:56 INFO - 2015-12-29 20:59:56,762 DEBUG : BROWSER_OUTPUT: 20:59:56 INFO - 2015-12-29 20:59:56,762 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.20 Median:62.50 stddev:3.16 (5.0%) stddev-sans-first:2.55 20:59:56 INFO - 2015-12-29 20:59:56,762 DEBUG : BROWSER_OUTPUT: Values: 69.0 61.0 61.0 61.0 62.0 63.0 62.0 63.0 61.0 69.0 20:59:56 INFO - 2015-12-29 20:59:56,762 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 20:59:56 INFO - 2015-12-29 20:59:56,762 DEBUG : BROWSER_OUTPUT: 20:59:57 INFO - 2015-12-29 20:59:57,382 INFO : Browser exited with error code: 0 20:59:57 INFO - 2015-12-29 20:59:57,433 INFO : Completed test kraken (00:00:57) 20:59:57 INFO - 2015-12-29 20:59:57,433 INFO : Starting test v8_7 20:59:57 INFO - 2015-12-29 20:59:57,433 DEBUG : operating with platform_type : linux_ 20:59:57 INFO - 2015-12-29 20:59:57,433 INFO : Initialising browser for v8_7 test... 20:59:57 INFO - 2015-12-29 20:59:57,440 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmplr25Jh/profile http://localhost:54114/getInfo.html 21:00:00 INFO - 2015-12-29 21:00:00,990 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 21:00:00 INFO - 2015-12-29 21:00:00,990 DEBUG : BROWSER_OUTPUT: colorDepth:24 21:00:00 INFO - 2015-12-29 21:00:00,991 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 21:00:00 INFO - 2015-12-29 21:00:00,991 DEBUG : BROWSER_OUTPUT: __metrics 21:00:01 INFO - 2015-12-29 21:00:01,079 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:00:02 INFO - 2015-12-29 21:00:02,378 INFO : Browser initialized. 21:00:02 INFO - 2015-12-29 21:00:02,378 INFO : Running cycle 1/1 for v8_7 test... 21:00:02 INFO - 2015-12-29 21:00:02,379 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmplr25Jh/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 21:00:13 INFO - 2015-12-29 21:00:13,852 DEBUG : BROWSER_OUTPUT: RSS: Main: 128708608 21:00:13 INFO - 2015-12-29 21:00:13,852 DEBUG : BROWSER_OUTPUT: 21:00:35 INFO - 2015-12-29 21:00:35,232 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54114/tests/v8_7/run.html (next: http://localhost:54114/tests/v8_7/run.html) 21:00:35 INFO - 2015-12-29 21:00:35,483 DEBUG : BROWSER_OUTPUT: RSS: Main: 416423936 21:00:35 INFO - 2015-12-29 21:00:35,483 DEBUG : BROWSER_OUTPUT: 21:00:35 INFO - 2015-12-29 21:00:35,484 DEBUG : BROWSER_OUTPUT: __start_tp_report 21:00:35 INFO - 2015-12-29 21:00:35,484 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 21:00:35 INFO - 2015-12-29 21:00:35,484 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 21:00:35 INFO - 2015-12-29 21:00:35,485 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 21:00:35 INFO - 2015-12-29 21:00:35,485 DEBUG : BROWSER_OUTPUT: |0;Richards;164.09583196586806 21:00:35 INFO - 2015-12-29 21:00:35,485 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;164.39256945586058 21:00:35 INFO - 2015-12-29 21:00:35,485 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.662363177098 21:00:35 INFO - 2015-12-29 21:00:35,485 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4985.074626865671 21:00:35 INFO - 2015-12-29 21:00:35,485 DEBUG : BROWSER_OUTPUT: |4;RayTrace;946.969696969697 21:00:35 INFO - 2015-12-29 21:00:35,485 DEBUG : BROWSER_OUTPUT: |5;Earley;554.016620498615 21:00:35 INFO - 2015-12-29 21:00:35,485 DEBUG : BROWSER_OUTPUT: |6;Boyer;10479.166666666666 21:00:35 INFO - 2015-12-29 21:00:35,485 DEBUG : BROWSER_OUTPUT: |7;RegExp;24214.285714285714 21:00:35 INFO - 2015-12-29 21:00:35,485 DEBUG : BROWSER_OUTPUT: |8;Splay;516.9753086419753 21:00:35 INFO - 2015-12-29 21:00:35,485 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4817.307692307692 21:00:35 INFO - 2015-12-29 21:00:35,485 DEBUG : BROWSER_OUTPUT: __end_tp_report 21:00:35 INFO - 2015-12-29 21:00:35,486 DEBUG : BROWSER_OUTPUT: __startTimestamp1451451635484__endTimestamp 21:00:35 INFO - 2015-12-29 21:00:35,486 DEBUG : BROWSER_OUTPUT: 21:00:35 INFO - 2015-12-29 21:00:35,487 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 21:00:35 INFO - 2015-12-29 21:00:35,487 DEBUG : BROWSER_OUTPUT: Number of tests: 10 21:00:35 INFO - 2015-12-29 21:00:35,487 DEBUG : BROWSER_OUTPUT: 21:00:35 INFO - 2015-12-29 21:00:35,488 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:164.10 Median:164.10 stddev:0.00 (0.0%) 21:00:35 INFO - 2015-12-29 21:00:35,488 DEBUG : BROWSER_OUTPUT: Values: 164.1 21:00:35 INFO - 2015-12-29 21:00:35,488 DEBUG : BROWSER_OUTPUT: 21:00:35 INFO - 2015-12-29 21:00:35,488 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:164.39 Median:164.39 stddev:0.00 (0.0%) 21:00:35 INFO - 2015-12-29 21:00:35,488 DEBUG : BROWSER_OUTPUT: Values: 164.4 21:00:35 INFO - 2015-12-29 21:00:35,488 DEBUG : BROWSER_OUTPUT: 21:00:35 INFO - 2015-12-29 21:00:35,489 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.66 Median:280.66 stddev:0.00 (0.0%) 21:00:35 INFO - 2015-12-29 21:00:35,489 DEBUG : BROWSER_OUTPUT: Values: 280.7 21:00:35 INFO - 2015-12-29 21:00:35,489 DEBUG : BROWSER_OUTPUT: 21:00:35 INFO - 2015-12-29 21:00:35,489 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4985.07 Median:4985.07 stddev:0.00 (0.0%) 21:00:35 INFO - 2015-12-29 21:00:35,489 DEBUG : BROWSER_OUTPUT: Values: 4985.1 21:00:35 INFO - 2015-12-29 21:00:35,490 DEBUG : BROWSER_OUTPUT: 21:00:35 INFO - 2015-12-29 21:00:35,490 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:946.97 Median:946.97 stddev:0.00 (0.0%) 21:00:35 INFO - 2015-12-29 21:00:35,490 DEBUG : BROWSER_OUTPUT: Values: 947.0 21:00:35 INFO - 2015-12-29 21:00:35,490 DEBUG : BROWSER_OUTPUT: 21:00:35 INFO - 2015-12-29 21:00:35,490 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:554.02 Median:554.02 stddev:0.00 (0.0%) 21:00:35 INFO - 2015-12-29 21:00:35,491 DEBUG : BROWSER_OUTPUT: Values: 554.0 21:00:35 INFO - 2015-12-29 21:00:35,491 DEBUG : BROWSER_OUTPUT: 21:00:35 INFO - 2015-12-29 21:00:35,491 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10479.17 Median:10479.17 stddev:0.00 (0.0%) 21:00:35 INFO - 2015-12-29 21:00:35,491 DEBUG : BROWSER_OUTPUT: Values: 10479.2 21:00:35 INFO - 2015-12-29 21:00:35,491 DEBUG : BROWSER_OUTPUT: 21:00:35 INFO - 2015-12-29 21:00:35,491 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24214.29 Median:24214.29 stddev:0.00 (0.0%) 21:00:35 INFO - 2015-12-29 21:00:35,492 DEBUG : BROWSER_OUTPUT: Values: 24214.3 21:00:35 INFO - 2015-12-29 21:00:35,492 DEBUG : BROWSER_OUTPUT: 21:00:35 INFO - 2015-12-29 21:00:35,492 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:516.98 Median:516.98 stddev:0.00 (0.0%) 21:00:35 INFO - 2015-12-29 21:00:35,492 DEBUG : BROWSER_OUTPUT: Values: 517.0 21:00:35 INFO - 2015-12-29 21:00:35,492 DEBUG : BROWSER_OUTPUT: 21:00:35 INFO - 2015-12-29 21:00:35,493 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4817.31 Median:4817.31 stddev:0.00 (0.0%) 21:00:35 INFO - 2015-12-29 21:00:35,493 DEBUG : BROWSER_OUTPUT: Values: 4817.3 21:00:35 INFO - 2015-12-29 21:00:35,493 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 21:00:35 INFO - 2015-12-29 21:00:35,493 DEBUG : BROWSER_OUTPUT: 21:00:36 INFO - 2015-12-29 21:00:36,154 INFO : Browser exited with error code: 0 21:00:36 INFO - 2015-12-29 21:00:36,171 INFO : Completed test v8_7 (00:00:38) 21:00:36 INFO - 2015-12-29 21:00:36,498 INFO : Completed test suite (00:20:05) 21:00:36 INFO - 2015-12-29 21:00:36,499 DEBUG : Working with test: dromaeo_css 21:00:36 INFO - 2015-12-29 21:00:36,499 DEBUG : Generating results file: dromaeo_css 21:00:36 INFO - 2015-12-29 21:00:36,500 DEBUG : Working with test: kraken 21:00:36 INFO - 2015-12-29 21:00:36,501 DEBUG : Generating results file: kraken 21:00:36 INFO - 2015-12-29 21:00:36,501 INFO : javascript benchmark 21:00:36 INFO - 2015-12-29 21:00:36,501 DEBUG : Working with test: v8_7 21:00:36 INFO - 2015-12-29 21:00:36,501 DEBUG : Generating results file: v8_7 21:00:36 INFO - 2015-12-29 21:00:36,501 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 21:00:36 INFO - 2015-12-29 21:00:36,579 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,53,35]] 21:00:36 INFO - 2015-12-29 21:00:36,579 DEBUG : process_Request line: dromaeo_css 7330.49 graph.html#tests=[[72,53,35]] 21:00:36 INFO - 2015-12-29 21:00:36,579 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 21:00:36 INFO - 2015-12-29 21:00:36,622 DEBUG : process_Request line: kraken 1459.20 graph.html#tests=[[232,53,35]] 21:00:36 INFO - 2015-12-29 21:00:36,622 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 21:00:36 INFO - 2015-12-29 21:00:36,697 DEBUG : process_Request line: v8_7 23422.23 graph.html#tests=[[230,53,35]] 21:00:36 INFO - 2015-12-29 21:00:36,698 INFO : javascript benchmark 21:00:36 INFO - 2015-12-29 21:00:36,702 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3308.6029676438825, 3389.593248810143, 3419.675130862569, 3419.9911026247237, 3456.8444420001097, 5594.076977298746, 5640.294963129609, 5670.631408958415, 5675.914861277084, 5677.545796336293, 5637.098064309711, 5644.8024319148835, 5655.971720141393, 5666.461686139821, 5701.173329867167, 4958.231474121517, 5154.92267615986, 5170.121079416508, 5242.030224408478, 5253.553447956909, 5098.311727916739, 5108.284840122367, 5131.948680513185, 5135.871603209931, 5137.049645815536, 5053.267276244942, 5067.923981140268, 5172.0, 5179.766910489018, 5180.974095129538, 5157.5100365465405, 5158.303629010092, 5166.483351664803, 5166.7416629168765, 5170.172772356443, 5091.9236211456855, 5136.84589462313, 5196.8960620787375, 5201.271821944931, 5275.050490911634, 5205.817796377109, 5289.656172348785, 5314.0, 5406.648567843077, 5430.185472179165, 6059.7273122709585, 6138.0792881067755, 6159.661218632973, 6161.476274516672, 6179.196704428396, 5850.6782126983, 6212.81361559154, 6217.626942383471, 6222.875542489171, 6230.906536401958, 5598.804041858556, 5607.663540187602, 5729.455701708331, 5734.111212761987, 5764.654120752768, 6167.629942203482, 6185.783497577563, 6194.101855230966, 6196.752129914753, 6196.907046394308, 5733.283339582552, 5841.824745257649, 6003.489703375262, 6031.728572214173, 6035.818925432244, 5919.200907877467, 6055.303640081359, 6065.120557519135, 6067.878642427127, 6087.939120608826, 6041.305249896318, 6086.391360863967, 6088.086786981989, 6092.7562897484495, 6096.329403765582, 5845.240118784616, 5951.464368206795, 5992.550558708114, 6045.21412216409, 6073.726682299307, 4554.863354099382, 4599.701019433726, 4602.608778253819, 4642.5821676048645, 4661.790219440133, 4179.26862799009, 4216.662666986634, 4229.703920725581, 4232.36514522824, 4247.766372849523, 5563.916541251884, 5802.187693722883, 5856.531477481792, 5863.0, 5865.266841644794, 5948.315943666447, 5974.0, 6035.1249068885645, 6040.365761595057, 6067.0, 5680.630759000652, 5694.515966142924, 5697.715114244271, 5697.800576979786, 5700.6009579329875, 5078.5175408336145, 5190.792368305226, 5272.209168624737, 5298.0, 5309.203619457112, 6184.350643182491, 6279.434850863353, 6306.211723534559, 6313.9368606314265, 6314.084457753692, 6030.758769649165, 6113.14415981754, 6118.143459915705, 6119.602225855305, 6122.724477398617, 6105.84735381619, 6139.048447490646, 6212.1303017578475, 6310.558260921692, 6333.145025421509, 6037.698115094316, 6039.335673076046, 6039.909401359071, 6044.969775151096, 6048.183495228088, 6132.325444201224, 6137.754489820536, 6141.570090093651, 6144.047672610753, 6144.262688477412, 5685.346185188756, 5763.0, 5852.7658893643775, 5978.432048955342, 5979.103134529855, 5884.7940322088525, 5922.348541660328, 5951.940480595139, 5962.19510366095, 5970.283565972111, 5841.970790146022, 5848.444397782204, 5859.384764599656, 5866.735996880066, 5867.119932010232, 5746.655200687972, 5849.444302791228, 5866.178734977021, 6009.278886533644, 6019.127226552213, 5897.233359663216, 5901.0, 5903.586748927534, 5904.940950590439, 5913.881722365442], "unit": "ms", "name": "dojo.html", "value": 5589.145274565762}, {"lowerIsBetter": false, "replicates": [591.4174538079991, 616.9850595769956, 634.8635043465654, 636.8758092172027, 651.6676494987557, 32617.0, 42821.78589107054, 43436.78281608588, 43544.782276088656, 43577.99999999996, 46495.53504464954, 46953.0, 47115.29327060097, 47181.52818471814, 47245.763771181184, 8172.223638754309, 8287.502749835, 8946.642134314636, 9071.863922041175, 9145.176934075931, 10818.404987725671, 11069.0, 11075.556977720922, 11078.833817492745, 11080.224384293102, 10704.839427408595, 10795.514201860935, 10808.243422960395, 10816.891831081668, 10818.837717434244, 10407.219458540601, 10482.318649287849, 10487.423191724452, 10488.0, 10496.265261431703, 10544.525496352606, 10624.628138015132, 10673.83989240162, 10696.197785166067, 10698.62554810578, 43598.34602480965, 43999.78000110011, 44039.33940990888, 44064.339034914185, 44087.11825763467, 3620.185458271868, 3669.4862719219063, 3684.5578530576236, 3755.75587586806, 3788.488554045196, 32975.6702432975, 32984.6701532984, 33142.6685733142, 33465.16337091592, 33508.83245583781, 3678.6321367863266, 3740.6259374062647, 3765.0963768695588, 3904.2581909437117, 3911.02224443889, 318649.0, 319894.0, 320269.0, 320395.3980230107, 321736.0, 60015.69992150011, 60853.39146608566, 69169.65415172892, 69725.0, 70078.64960675164, 63971.0, 64285.67857160778, 64318.0, 64558.0, 64634.67682661556, 17465.825341746673, 17958.551036223937, 17968.371107011193, 17969.550761231072, 17973.37093201732, 13533.66165845842, 13585.456581736818, 13611.931940340235, 13820.516281930286, 13863.237521936391, 22415.32754017382, 22930.19744308941, 22966.54066918652, 22970.65544016841, 22975.310740677807, 8539.615717292736, 8739.956300218586, 8755.212030917248, 8832.64669413229, 8944.776380590538, 1038.7558923652934, 1041.0838462153256, 1080.6487891435315, 1085.1644233939821, 1219.4518405606213, 30289.458984998473, 30469.0, 30552.388952221274, 31204.063878083693, 31312.0, 1139.225326777799, 1154.3881742676394, 1255.976379250926, 1259.4634545854044, 1260.155695683894, 13988.58034258974, 15875.52373428799, 15981.760273595906, 16016.839831601535, 16310.592235194215, 308016.2995925075, 309286.0, 310747.0, 311022.0, 311167.0, 50837.74581127071, 51639.0, 54284.728576356865, 54496.0, 57742.133867992015, 1460.0509668715208, 1470.2942587558032, 1478.268257212665, 1497.213962669607, 1584.635533827203, 28700.0, 28975.275618109717, 29945.70054299429, 30468.0, 31300.217494562818, 49800.0, 49920.750396247786, 50134.0, 50182.749086254335, 50264.24603630875, 311966.0, 312099.0, 313398.0, 313586.0, 314374.0, 36029.27941441209, 36227.27545449129, 36599.81700091482, 51087.74456127696, 51275.743621283145, 47663.0, 48085.5191448081, 48095.519044810506, 48946.51053489562, 49138.50861491483, 45266.547334526236, 45319.32021019753, 46399.3040104392, 46818.53181468142, 47137.05725885394, 45195.54804452045, 45325.546744532134, 46304.30543541917, 46547.0, 47089.764551177024, 41061.58938410578, 41149.588504114574, 41215.587844121175, 41505.58494415017, 41590.58409415867, 35891.0, 36223.0, 38905.0, 40599.3910091343, 41401.58598414098, 26956.865215673795, 27380.0, 27509.17472475829, 27801.0, 27855.860720696266], "unit": "ms", "name": "ext.html", "value": 20784.493834172492}, {"lowerIsBetter": false, "replicates": [380.84195059050495, 382.78372719413545, 382.96553310202074, 386.2468187035281, 386.35671606774724, 12796.0, 15251.466198683049, 17875.0, 20702.68945965812, 20773.792262077375, 13238.338083095854, 13486.730265394686, 13563.660908477294, 19786.802131978675, 19996.30012949547, 4804.951950480494, 4928.1129396708575, 4928.285398617199, 4931.161702510564, 4933.161362568372, 3875.3218186817335, 3964.167524819791, 4854.17479028566, 5284.894302113956, 5411.242426060355, 5283.260343551887, 5287.920681189786, 5304.257403963448, 5352.91970620441, 5362.43694412087, 5012.774425150877, 5109.718965456898, 5126.026055049529, 5132.0249152661245, 5311.1502159654465, 4473.351364052227, 4476.820927162909, 4487.080148569568, 4489.573490518395, 4491.9775401123115, 15175.0, 15203.543893683207, 15417.768733469007, 15473.613159670986, 15482.458113965957, 2190.2224710227956, 2212.8451008429415, 2245.3825198070663, 2333.4516388648653, 2355.057976809273, 11117.944410277896, 11165.330080195134, 11263.605773797877, 11360.829587556193, 11464.025557827596, 1847.759791227132, 1937.7190307405347, 1945.3483083167157, 2003.9599208015904, 2006.2476571285767, 64210.35789642091, 69863.0, 70604.29395706029, 70935.0, 71880.64059679721, 7888.684452621946, 7990.880136797953, 8069.556174410346, 8105.432619716563, 8106.189381061965, 9611.279154063473, 9621.374610650286, 9637.084476974676, 9643.662471813594, 9655.758606034906, 6406.199225096863, 6477.740890364427, 6479.902801457982, 6523.641199733966, 6524.380183882524, 6734.427573656196, 6755.054292399068, 6766.458683305324, 6768.255491895888, 6794.76218332356, 3675.0996005978704, 3723.8510459581853, 3726.4596633488536, 3754.2303827715255, 3761.6990640749223, 1241.7951038078616, 1260.1305099481328, 1274.7450509898058, 1304.706441050756, 1316.7030474982134, 535.5688670620189, 551.159481790273, 559.4126167524083, 578.5024878604397, 581.0905932216068, 11645.475953582109, 13166.210027398387, 13215.207087574776, 13572.864271357357, 13613.387397567134, 573.1402895656515, 573.5440324941682, 580.4311774461052, 585.493548080907, 598.1804927249609, 7087.964560177166, 7226.385757210591, 7379.520331178456, 7402.888956665654, 7407.296306850841, 622456.0, 626652.0, 645561.0, 646765.0, 658963.0, 78245.60877195577, 78884.21115788883, 80974.0, 81088.0, 82521.58739206386, 606.1180981671657, 616.8550390658191, 623.5884316351187, 623.7536173211556, 624.6845343101795, 11687.298762074302, 11763.882361176278, 12097.697557561132, 12548.749025019266, 12884.742305154032, 39009.0, 39389.6061039386, 39962.201700922946, 40881.79559102185, 41176.17647646971, 52505.47494525006, 54248.0, 55013.0, 55196.0, 55528.72235638796, 7628.771136865903, 7833.0, 14217.928910355382, 14476.927615361856, 14645.633859153606, 19680.92224276274, 21244.681329780375, 21404.357869263946, 21417.571648567253, 21763.23828665989, 17278.136093195542, 17497.12514374251, 17726.379576714753, 17760.28958841632, 18059.0, 16600.50198494047, 16616.0, 16908.23912923946, 17243.65512689714, 17572.91213543924, 12022.939885300868, 14558.272086395426, 16271.59321016984, 16656.750148747535, 16869.493915182564, 16312.592185195464, 16424.75362869534, 16453.68370530331, 16650.750238746186, 16662.50012499627, 16502.66994660124, 16541.751873722144, 16742.665146696756, 16891.831081689517, 17165.828341716922], "unit": "ms", "name": "jquery.html", "value": 8434.129225093939}, {"lowerIsBetter": false, "replicates": [1564.1631727026042, 1570.9450169244071, 1827.7258411238313, 1857.025061842532, 1864.9254029838808, 8142.104368519465, 8307.916920830783, 8319.33445324374, 8319.792005199874, 8322.459040162394, 8491.065982741893, 8537.487750734961, 8544.957275213616, 8558.914410855905, 8559.0, 2447.840890342131, 2460.2127319257843, 2473.9134130305442, 2478.615814548748, 2481.1936120760734, 2437.0251899240357, 2465.6301554766837, 2472.221250306157, 2473.925782226527, 2474.1464194852747, 2108.8102070813625, 2144.345974477784, 2361.114582031738, 2459.8401103928277, 2473.2951108933958, 2353.070537137821, 2362.3739708977137, 2371.620540713486, 2374.560706269337, 2375.0499800079933, 2409.9156529521383, 2466.531359041794, 2469.9753002470106, 2470.1354525915967, 2471.6292556116546, 7462.813429664247, 7707.421943354215, 8307.626156822958, 8462.0, 8463.957680211559, 4935.679180853269, 5023.748812559357, 5024.9748751256375, 5025.246213068032, 5028.547430731252, 3410.5054767058887, 3416.538767266412, 3436.27838153988, 3545.0960005198767, 3561.216532362876, 1128.0862501373913, 1137.5790957345753, 1143.5540139345662, 1148.3167515328366, 1153.0314535789894, 12021.459034343388, 12056.517739290417, 12072.698182545419, 12084.637460876187, 12099.21355111906, 4708.505606911293, 4732.550407711262, 4755.476897541268, 4784.473707892129, 4786.880327991828, 10071.798564028679, 10098.141657959155, 10099.091081802673, 10101.64644237463, 10105.090541851268, 5267.894642107136, 5270.209468579667, 5274.156135018456, 5276.182191760283, 5280.6039547034125, 4778.808847646124, 4785.856424307276, 4790.880227994328, 4795.400574928134, 4799.160146974265, 3891.902702432462, 3908.022994251437, 3911.7457365271166, 3923.136909879879, 3942.4086387042175, 1306.431702209542, 1317.0648839324188, 1318.5648735917125, 1326.2374134872487, 1328.5350127455313, 1405.9367328470244, 1414.3635364086203, 1415.0309724606273, 1431.5991522373752, 1431.6063082652354, 7840.176781437981, 7850.332721718603, 7875.763727088197, 7906.407019473562, 7910.7231246906085, 517.9896402071937, 524.6275144647267, 524.6589716684185, 527.5963887625969, 530.4059453412126, 5964.1650168976375, 5988.730507127189, 6396.584222025554, 6452.257990331078, 6457.4511166551365, 9991.100800927952, 10237.641682541076, 10271.897281027244, 10287.125594324567, 10289.2797504174, 9930.2055835533, 10120.038596333337, 10272.280940334254, 10302.484875756183, 10317.535710893027, 7880.842383152305, 7902.960485197537, 7933.880991785128, 7955.681772729142, 7966.6415011324625, 7763.068431787996, 7881.448298619041, 7896.802579935547, 7898.249666281694, 7902.130765615892, 9100.954495227747, 9182.862257066015, 9186.632534698538, 9208.815823683623, 9225.215856651992, 9286.30352723562, 9443.858342124737, 9453.574589143642, 9487.952560237154, 9504.239660827256, 7401.185869554452, 7529.661165247468, 7588.886166707393, 7668.1181664109345, 7674.9232507674205, 8319.50082994998, 8325.25072743456, 8336.87494687568, 8385.748427547183, 8389.11914248995, 7712.5758083305955, 7816.53100813953, 7878.0, 7934.325582325567, 8023.719169829028, 7740.109887363025, 7781.766547003599, 7857.724979625686, 7903.525788452711, 7961.323287520626, 7372.0, 7480.775576732707, 7526.924730752622, 7529.134149572869, 7543.962280188784, 7216.242294559206, 7251.746188883575, 7262.854742905007, 7265.382442492236, 7268.527545709512, 6955.374016338554, 6974.267701891228, 6993.125859267591, 6996.930030699831, 6997.685104170223], "unit": "ms", "name": "mootools.html", "value": 4814.838142074524}, {"lowerIsBetter": false, "replicates": [352.1811787593845, 359.28860855506116, 362.1092113401034, 368.1514109976505, 368.41973891121484, 5789.942100579004, 5872.324682661495, 5884.6763428011545, 5906.350301466835, 5915.083162109869, 5717.171010203518, 5832.854178645536, 5837.387074357195, 5842.941570584293, 5866.149408335788, 4609.516000819916, 4627.421572303462, 4629.213033784265, 4634.536546345355, 4635.049814787961, 4477.955220447802, 4545.36364908913, 4553.225951588238, 4625.398698169233, 4657.836975705851, 4578.198815207342, 4583.083383323332, 4586.312053192015, 4595.770211489429, 4595.908081838361, 4537.523560026183, 4578.084383123372, 4593.862184134465, 4599.264117741145, 4602.7008244464005, 4090.795460226977, 4113.568075352075, 4113.732607380511, 4119.546849846514, 4124.546299907008, 5521.254630624854, 5620.437956204388, 5640.238567793377, 5650.491455768959, 5688.97155514224, 5389.703566303851, 5393.029254734146, 5393.487618676219, 5395.622306438551, 5397.379301380352, 6002.429769171922, 6263.342349053375, 6268.686565671698, 6269.905951410732, 6270.6864656766975, 4424.867253982354, 4529.750863702495, 4569.95430045702, 4579.67942244043, 4584.793684284182, 6275.717592708339, 6323.20959880015, 6368.172137622126, 6371.553991220663, 6386.68066596673, 4646.186917289461, 4670.789814458358, 4678.1813182692895, 4681.368015317957, 4682.836100736526, 4690.132325519721, 4706.905861882743, 4746.5728084471875, 4788.545088216614, 4796.064767370399, 5354.223637572531, 5370.946290537123, 5374.435684253097, 5374.48942350476, 5374.677519348852, 6245.375462453719, 6245.812625621148, 6252.406021427957, 6255.12428260044, 6257.061440783918, 1719.1576127697338, 1740.1473278093897, 1740.6779745746824, 1740.825917408249, 1741.1555395633109, 1179.9705007374712, 1200.9971673652424, 1203.8916497515265, 1214.4231490042337, 1231.6058861164342, 5993.370696076936, 5999.370066143079, 6002.939970600238, 6005.249343832021, 6005.909911351333, 6330.651814150174, 6341.429271365507, 6346.30190679025, 6347.492200624031, 6357.760236753881, 5879.147523609053, 5975.19334889793, 5989.580729348903, 5990.371011043778, 5993.280806303272, 3525.6474352564537, 3540.592831824373, 3549.8757543485854, 3553.2893421315325, 3555.253396786704, 6593.670316484253, 6647.833804154935, 6654.50091243149, 6654.500912431587, 6664.233613134552, 6567.934320656828, 6574.474042076622, 6578.901316480256, 6579.342065793382, 6580.144581204413, 6508.9023664645065, 6629.0, 6637.037629543689, 6645.136132302867, 6648.867022659423, 6239.656818875005, 6307.968460157854, 6326.778562750282, 6420.165378500765, 6431.485481161402, 6329.145565348619, 6330.936690633219, 6338.397852204033, 6341.968290158704, 6346.1432706585865, 6598.274189839018, 6604.537682362381, 6608.966955165386, 6612.4710023198995, 6615.669216539058, 4564.950061485811, 4625.560571745679, 4630.83792067276, 4635.351050852816, 4667.836625718083, 6419.935800642121, 6423.357664233539, 6434.517411194086, 6517.217933847968, 6523.0, 6336.619802811846, 6344.71448784815, 6346.365363463617, 6350.206224221973, 6351.333110023381, 6217.595856269328, 6299.811005669837, 6325.209348831396, 6331.556791024584, 6339.207599050119, 6192.535559832941, 6196.411340922605, 6196.938030619636, 6198.938010619836, 6206.038064100072, 6327.905081423874, 6334.841628959313, 6339.429451349401, 6340.080688300079, 6345.682715864096, 6106.816795496142, 6185.969070154621, 6200.0, 6209.720562574605, 6210.813675589739], "unit": "ms", "name": "prototype.html", "value": 4803.910364859779}, {"lowerIsBetter": false, "replicates": [821.8931538899942, 850.2815121222567, 900.7973206028645, 967.463058002809, 978.1050338939871, 14267.143971361713, 14524.419023239085, 14583.052101613388, 14617.853821461782, 14638.0, 13535.864641353584, 13637.590872273822, 13640.0, 13643.590692279222, 13661.590152295423, 764.5565571968245, 767.87330090535, 886.3972498700881, 912.0286894457381, 917.312015988009, 909.0682050897816, 912.0560220172123, 912.192709452133, 918.2103391083696, 918.3984490158956, 799.5922079739346, 950.5769932380093, 963.291980394413, 963.6386355116831, 966.038791402552, 788.8501184774904, 955.8470644696849, 960.342165616548, 964.4502633498909, 965.3725078698832, 719.0472623773521, 720.2113685514354, 725.4124159430878, 725.9201487836334, 726.1504040272894, 14234.288285585782, 14364.497242596459, 14412.063215890934, 14437.0, 14437.278136093153, 13622.93188534051, 14003.019788614802, 14042.0, 14129.646758831112, 14324.283785810772, 10431.0, 10795.946020269927, 10860.076893464066, 11037.0, 11051.392173430459, 3864.087276798003, 3894.883153505399, 3908.4918960535233, 3942.3889297158985, 3969.6030396960364, 54727.17909231365, 54985.1752223717, 55003.32471739867, 55071.449285507435, 55913.0, 9648.324617276863, 9848.162906152915, 9966.750831229132, 9985.0, 9986.550605222783, 19125.713114303297, 19131.521711957314, 19153.425397238105, 19159.425217243504, 19182.0, 8187.26314631686, 8478.94013248344, 8529.74410767678, 8666.78333041679, 8669.0, 4765.8570242892765, 4911.287863259879, 4971.2543118531785, 4986.526280003394, 5025.14572522672, 3242.5946756655417, 3281.3273278977754, 3289.8190599517256, 3376.18971446851, 3422.7261819054415, 540.4595404595404, 545.1087471983336, 546.0880329849082, 548.0600769680018, 554.7614525753964, 615.3139249736512, 655.7180412422608, 695.8886578147473, 708.3624737736079, 715.492000679513, 8515.0, 8823.205911467998, 8829.304759531522, 8877.0, 8914.86627700585, 450.82192533948904, 558.3774091887598, 693.549193024528, 694.5520139510089, 705.9788206353818, 4388.29787234041, 4407.537208593116, 4534.501204867462, 4568.314752787109, 4594.908101837945, 64545.0, 65140.0, 65388.67305663441, 68538.65730671414, 68903.65548172226, 53907.0, 54387.45612543903, 54494.45505544973, 56140.75413997458, 56911.71544142336, 55570.72214638982, 55780.442195577525, 56316.0, 56343.71828140833, 57290.713546432, 9345.719628411158, 9388.155066044088, 9676.177524910461, 9789.167920726533, 9806.362586431858, 41271.380929286686, 41423.0, 41598.0, 42136.57863421449, 42519.57480425156, 48708.0, 53006.4699353017, 53409.0, 53688.73155634353, 54270.45729542812, 8986.415882967585, 9350.579223934803, 9363.485008324607, 9375.85936210971, 9382.343235973416, 13530.594082177551, 13546.93226533861, 13913.0, 13983.44066237339, 14076.577702668936, 11679.416029198675, 11971.700707482383, 12102.878971210175, 12136.878631213574, 12173.513059477877, 12359.443825027716, 12530.749385012066, 12631.242125472501, 12845.935770321088, 13172.868271317548, 11782.088082102604, 11881.346525940811, 11989.460474278852, 12263.75472490563, 12499.625011249676, 10798.73003174927, 11164.888351116384, 11239.831402529133, 11321.433928303717, 11341.036011939077, 10267.691969240936, 10414.427206503715, 10415.1667866572, 10602.0, 10603.416812075102], "unit": "ms", "name": "yui.html", "value": 6846.321032047811}], "name": "dromaeo_css", "value": 7330.488775985118}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [107.0, 110.0, 104.0, 109.0, 109.0, 110.0, 101.0, 109.0, 108.0, 108.0], "unit": "ms", "name": "ai-astar", "value": 107.5}, {"lowerIsBetter": true, "replicates": [147.0, 127.0, 144.0, 156.0, 128.0, 148.0, 147.0, 123.0, 168.0, 124.0], "unit": "ms", "name": "audio-beat-detection", "value": 141.2}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 162.0, 162.0, 161.0, 162.0, 162.0, 164.0, 160.0, 160.0], "unit": "ms", "name": "audio-dft", "value": 161.4}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 72.0, 161.0, 71.0, 79.0, 71.0, 71.0, 148.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 89.0}, {"lowerIsBetter": true, "replicates": [89.0, 89.0, 134.0, 90.0, 89.0, 89.0, 131.0, 89.0, 89.0, 130.0], "unit": "ms", "name": "audio-oscillator", "value": 101.9}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 110.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 144.0, 145.0, 145.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.5}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [55.0, 54.0, 56.0, 54.0, 54.0, 54.0, 54.0, 55.0, 52.0, 53.0], "unit": "ms", "name": "json-parse-financial", "value": 54.1}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 63.0, 63.0, 63.0, 64.0, 63.0, 64.0, 64.0, 62.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 63.3}, {"lowerIsBetter": true, "replicates": [77.0, 77.0, 77.0, 78.0, 78.0, 80.0, 79.0, 78.0, 79.0, 78.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 78.1}, {"lowerIsBetter": true, "replicates": [115.0, 114.0, 110.0, 110.0, 115.0, 120.0, 117.0, 112.0, 110.0, 114.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 113.7}, {"lowerIsBetter": true, "replicates": [126.0, 135.0, 134.0, 135.0, 135.0, 140.0, 135.0, 137.0, 142.0, 135.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 135.4}, {"lowerIsBetter": true, "replicates": [69.0, 61.0, 61.0, 61.0, 62.0, 63.0, 62.0, 63.0, 61.0, 69.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 63.2}], "name": "kraken", "value": 1459.2}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [164.09583196586806], "unit": "score", "name": "Richards", "value": 215.13038799999993}, {"lowerIsBetter": false, "replicates": [164.39256945586058], "unit": "score", "name": "DeltaBlue", "value": 402.195794}, {"lowerIsBetter": false, "replicates": [280.662363177098], "unit": "score", "name": "Encrypt", "value": 948.4029029999999}, {"lowerIsBetter": false, "replicates": [4985.074626865671], "unit": "score", "name": "Decrypt", "value": 53.39558982035927}, {"lowerIsBetter": false, "replicates": [946.969696969697], "unit": "score", "name": "RayTrace", "value": 781.4283840000004}, {"lowerIsBetter": false, "replicates": [554.016620498615], "unit": "score", "name": "Earley", "value": 1202.9657150000005}, {"lowerIsBetter": false, "replicates": [10479.166666666666], "unit": "score", "name": "Boyer", "value": 63.59885487077532}, {"lowerIsBetter": false, "replicates": [24214.285714285714], "unit": "score", "name": "RegExp", "value": 37.621799410029524}, {"lowerIsBetter": false, "replicates": [516.9753086419753], "unit": "score", "name": "Splay", "value": 157.63035223880595}, {"lowerIsBetter": false, "replicates": [4817.307692307692], "unit": "score", "name": "NavierStokes", "value": 308.055888223553}], "name": "v8_7", "value": 23422.232712736703}]} 21:00:36 INFO - RETURN: dromaeo_css: 7330.49 21:00:36 INFO - RETURN: kraken: 1459.20 21:00:36 INFO - RETURN: v8_7: 23422.23 21:00:36 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,53,35]]", "result": "23422.23"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,53,35]]", "result": "1459.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,53,35]]", "result": "7330.49"}}} 21:00:36 INFO - Return code: 0 21:00:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 21:00:36 INFO - # TBPL SUCCESS # 21:00:36 INFO - Running post-action listener: _resource_record_post_action 21:00:36 INFO - Running post-run listener: _resource_record_post_run 21:00:37 INFO - Total resource usage - Wall time: 1221s; CPU: 13.0%; Read bytes: 4096; Write bytes: 332402688; Read time: 8; Write time: 217496 21:00:37 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 69812224; Read time: 0; Write time: 46056 21:00:37 INFO - run-tests - Wall time: 1207s; CPU: 13.0%; Read bytes: 4096; Write bytes: 261443584; Read time: 8; Write time: 171092 21:00:37 INFO - Running post-run listener: _upload_blobber_files 21:00:37 INFO - Blob upload gear active. 21:00:37 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 21:00:37 INFO - Copying logs to upload dir... 21:00:37 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1264.236607 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2015-12-29 21:00:37.372678) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-29 21:00:37.376899) ========= 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=ae8083fbfc14dfa356ee9053000001f7-1451448626.518699-1847082600 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1451442639/firefox-44.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009838 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1451442639/firefox-44.0.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-29 21:00:37.429104) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 21:00:37.429490) ========= 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=ae8083fbfc14dfa356ee9053000001f7-1451448626.518699-1847082600 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004527 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 21:00:37.479447) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-29 21:00:37.479770) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-29 21:00:37.480076) ========= ========= Total master_lag: 0.63 =========