builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-023 starttime: 1450255117.69 results: success (0) buildid: 20151215222209 builduid: c7d83ec7ec38466f80723d81083dda01 revision: b2d75585bfc4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-16 00:38:37.688289) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-16 00:38:37.688765) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-16 00:38:37.689082) ========= 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=e10134013339c31d8d0c4708000001d6-1450233150.717384-950284369 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006295 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-16 00:38:37.713586) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-16 00:38:37.713883) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-16 00:38:37.728143) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 00:38:37.728560) ========= 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=e10134013339c31d8d0c4708000001d6-1450233150.717384-950284369 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004576 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 00:38:37.778626) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-16 00:38:37.778912) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-16 00:38:37.779286) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 00:38:37.779556) ========= 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=e10134013339c31d8d0c4708000001d6-1450233150.717384-950284369 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-16 00:38:38-- 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% 46.8M=0s 2015-12-16 00:38:38 (46.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.179894 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 00:38:37.971681) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 00:38:37.972001) ========= 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=e10134013339c31d8d0c4708000001d6-1450233150.717384-950284369 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019751 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 00:38:38.022066) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 00:38:38.022410) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev b2d75585bfc4 --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 b2d75585bfc4 --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=e10134013339c31d8d0c4708000001d6-1450233150.717384-950284369 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-16 00:38:38,480 Setting DEBUG logging. 2015-12-16 00:38:38,480 attempt 1/10 2015-12-16 00:38:38,480 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/b2d75585bfc4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-16 00:38:38,846 unpacking tar archive at: mozilla-beta-b2d75585bfc4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.641486 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 00:38:38.677967) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-16 00:38:38.678247) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-16 00:38:38.696530) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-16 00:38:38.696811) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-16 00:38:38.697273) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2015-12-16 00:38:38.697620) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --system-bits 64 --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', '--system-bits', '64', '--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=e10134013339c31d8d0c4708000001d6-1450233150.717384-950284369 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:38:39 INFO - MultiFileLogger online at 20151216 00:38:39 in /builds/slave/test-pgo 00:38:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 00:38:39 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 00:38:39 INFO - {'append_to_log': False, 00:38:39 INFO - 'base_work_dir': '/builds/slave/test-pgo', 00:38:39 INFO - 'blob_upload_branch': 'Mozilla-Beta', 00:38:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 00:38:39 INFO - 'branch': 'Mozilla-Beta', 00:38:39 INFO - 'buildbot_json_path': 'buildprops.json', 00:38:39 INFO - 'config_files': ('talos/linux_config.py',), 00:38:39 INFO - 'default_actions': ('clobber', 00:38:39 INFO - 'read-buildbot-config', 00:38:39 INFO - 'download-and-extract', 00:38:39 INFO - 'populate-webroot', 00:38:39 INFO - 'create-virtualenv', 00:38:39 INFO - 'install', 00:38:39 INFO - 'run-tests'), 00:38:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:38:39 INFO - 'download_minidump_stackwalk': True, 00:38:39 INFO - 'download_symbols': 'ondemand', 00:38:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:38:39 INFO - 'tooltool.py': '/tools/tooltool.py', 00:38:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:38:39 INFO - '/tools/misc-python/virtualenv.py')}, 00:38:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:38:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:38:39 INFO - 'installer_path': 'installer.exe', 00:38:39 INFO - 'log_level': 'info', 00:38:39 INFO - 'log_name': 'talos', 00:38:39 INFO - 'log_to_console': True, 00:38:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:38:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:38:39 INFO - 'opt_config_files': (), 00:38:39 INFO - 'pip_index': False, 00:38:39 INFO - 'sps_profile': False, 00:38:39 INFO - 'sps_profile_interval': 0, 00:38:39 INFO - 'suite': 'dromaeojs', 00:38:39 INFO - 'system_bits': '64', 00:38:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:38:39 INFO - 'title': 'talos-linux64-ix-023', 00:38:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:38:39 INFO - 'use_talos_json': True, 00:38:39 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 00:38:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:38:39 INFO - 'work_dir': 'build'} 00:38:39 INFO - ##### 00:38:39 INFO - ##### Running clobber step. 00:38:39 INFO - ##### 00:38:39 INFO - Running pre-action listener: _resource_record_pre_action 00:38:39 INFO - Running main action method: clobber 00:38:39 INFO - rmtree: /builds/slave/test-pgo/build 00:38:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 00:38:40 INFO - Running post-action listener: _resource_record_post_action 00:38:40 INFO - ##### 00:38:40 INFO - ##### Running read-buildbot-config step. 00:38:40 INFO - ##### 00:38:40 INFO - Running pre-action listener: _resource_record_pre_action 00:38:40 INFO - Running main action method: read_buildbot_config 00:38:40 INFO - Using buildbot properties: 00:38:40 INFO - { 00:38:40 INFO - "properties": { 00:38:40 INFO - "buildnumber": 73, 00:38:40 INFO - "product": "firefox", 00:38:40 INFO - "script_repo_revision": "production", 00:38:40 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 00:38:40 INFO - "repository": "", 00:38:40 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 00:38:40 INFO - "buildid": "20151215222209", 00:38:40 INFO - "slavename": "talos-linux64-ix-023", 00:38:40 INFO - "pgo_build": "True", 00:38:40 INFO - "basedir": "/builds/slave/test-pgo", 00:38:40 INFO - "project": "", 00:38:40 INFO - "platform": "ubuntu64_hw", 00:38:40 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 00:38:40 INFO - "slavebuilddir": "test", 00:38:40 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 00:38:40 INFO - "branch": "mozilla-beta", 00:38:40 INFO - "repo_path": "releases/mozilla-beta", 00:38:40 INFO - "stage_platform": "linux64-pgo", 00:38:40 INFO - "builduid": "c7d83ec7ec38466f80723d81083dda01", 00:38:40 INFO - "revision": "b2d75585bfc4" 00:38:40 INFO - }, 00:38:40 INFO - "sourcestamp": { 00:38:40 INFO - "repository": "", 00:38:40 INFO - "hasPatch": false, 00:38:40 INFO - "project": "", 00:38:40 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 00:38:40 INFO - "changes": [ 00:38:40 INFO - { 00:38:40 INFO - "category": null, 00:38:40 INFO - "files": [ 00:38:40 INFO - { 00:38:40 INFO - "url": null, 00:38:40 INFO - "name": "http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450246929/firefox-44.0.en-US.linux-x86_64.tar.bz2" 00:38:40 INFO - } 00:38:40 INFO - ], 00:38:40 INFO - "repository": "", 00:38:40 INFO - "rev": "b2d75585bfc4", 00:38:40 INFO - "who": "sendchange", 00:38:40 INFO - "when": 1450255076, 00:38:40 INFO - "number": 7365134, 00:38:40 INFO - "comments": "Bug 1220010: Temporarily disable asyncInit_ r=me, a=bustage", 00:38:40 INFO - "project": "", 00:38:40 INFO - "at": "Wed 16 Dec 2015 00:37:56", 00:38:40 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 00:38:40 INFO - "revlink": "", 00:38:40 INFO - "properties": [ 00:38:40 INFO - [ 00:38:40 INFO - "buildid", 00:38:40 INFO - "20151215222209", 00:38:40 INFO - "Change" 00:38:40 INFO - ], 00:38:40 INFO - [ 00:38:40 INFO - "builduid", 00:38:40 INFO - "c7d83ec7ec38466f80723d81083dda01", 00:38:40 INFO - "Change" 00:38:40 INFO - ], 00:38:40 INFO - [ 00:38:40 INFO - "pgo_build", 00:38:40 INFO - "True", 00:38:40 INFO - "Change" 00:38:40 INFO - ] 00:38:40 INFO - ], 00:38:40 INFO - "revision": "b2d75585bfc4" 00:38:40 INFO - } 00:38:40 INFO - ], 00:38:40 INFO - "revision": "b2d75585bfc4" 00:38:40 INFO - } 00:38:40 INFO - } 00:38:40 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450246929/firefox-44.0.en-US.linux-x86_64.tar.bz2. 00:38:40 INFO - Running post-action listener: _resource_record_post_action 00:38:40 INFO - ##### 00:38:40 INFO - ##### Running download-and-extract step. 00:38:40 INFO - ##### 00:38:40 INFO - Running pre-action listener: _resource_record_pre_action 00:38:40 INFO - Running main action method: download_and_extract 00:38:40 INFO - mkdir: /builds/slave/test-pgo/build/tests 00:38: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')]} 00:38:40 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450246929/test_packages.json 00:38:40 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450246929/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 00:38:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450246929/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 00:38:40 INFO - Downloaded 1270 bytes. 00:38:40 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 00:38:40 INFO - Using the following test package requirements: 00:38:40 INFO - {u'common': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip'], 00:38:40 INFO - u'cppunittest': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 00:38:40 INFO - u'firefox-44.0.en-US.linux-x86_64.cppunittest.tests.zip'], 00:38:40 INFO - u'jittest': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 00:38:40 INFO - u'jsshell-linux-x86_64.zip'], 00:38:40 INFO - u'mochitest': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 00:38:40 INFO - u'firefox-44.0.en-US.linux-x86_64.mochitest.tests.zip'], 00:38:40 INFO - u'mozbase': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip'], 00:38:40 INFO - u'reftest': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 00:38:40 INFO - u'firefox-44.0.en-US.linux-x86_64.reftest.tests.zip'], 00:38:40 INFO - u'talos': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 00:38:40 INFO - u'firefox-44.0.en-US.linux-x86_64.talos.tests.zip'], 00:38:40 INFO - u'web-platform': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 00:38:40 INFO - u'firefox-44.0.en-US.linux-x86_64.web-platform.tests.zip'], 00:38:40 INFO - u'webapprt': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip'], 00:38:40 INFO - u'xpcshell': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 00:38:40 INFO - u'firefox-44.0.en-US.linux-x86_64.xpcshell.tests.zip']} 00:38:40 INFO - Downloading packages: [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:38: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')]} 00:38:40 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450246929/firefox-44.0.en-US.linux-x86_64.common.tests.zip 00:38:40 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450246929/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 00:38:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450246929/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 00:38:48 INFO - Downloaded 22571743 bytes. 00:38:48 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 00:38:48 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip 00:38:48 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 00:38:49 INFO - Return code: 0 00:38:49 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 00:38:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:38:49 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450246929/firefox-44.0.en-US.linux-x86_64.common.tests.zip 00:38:49 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450246929/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 00:38:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450246929/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 00:38:49 INFO - Downloaded 22571743 bytes. 00:38:49 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 00:38:49 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip 00:38:49 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 00:38:50 INFO - Return code: 0 00:38:50 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')]} 00:38:50 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450246929/firefox-44.0.en-US.linux-x86_64.talos.tests.zip 00:38:50 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450246929/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 00:38:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450246929/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 00:38:56 INFO - Downloaded 11131970 bytes. 00:38:56 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 00:38:56 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.talos.tests.zip 00:38:56 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 00:38:56 INFO - Return code: 0 00:38: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')]} 00:38:56 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450246929/firefox-44.0.en-US.linux-x86_64.tar.bz2 00:38:56 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450246929/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 00:38:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450246929/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 00:39:02 INFO - Downloaded 56629990 bytes. 00:39:02 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450246929/firefox-44.0.en-US.linux-x86_64.tar.bz2 00:39:02 INFO - mkdir: /builds/slave/test-pgo/properties 00:39:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 00:39:02 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 00:39:02 INFO - Contents: 00:39:02 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450246929/firefox-44.0.en-US.linux-x86_64.tar.bz2 00:39:02 INFO - Running post-action listener: _resource_record_post_action 00:39:02 INFO - Running post-action listener: set_extra_try_arguments 00:39:02 INFO - ##### 00:39:02 INFO - ##### Running populate-webroot step. 00:39:02 INFO - ##### 00:39:02 INFO - Running pre-action listener: _resource_record_pre_action 00:39:02 INFO - Running main action method: populate_webroot 00:39:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:39:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:39:02 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 00:39:02 INFO - '../fennec_ids.txt'], 00:39:02 INFO - 'tests': ['tcheck2']}, 00:39:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:39:02 INFO - '--tppagecycles', 00:39:02 INFO - '7'], 00:39:02 INFO - 'tests': ['tsvgm']}}, 00:39:02 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 00:39:02 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 00:39:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:39:02 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 00:39:02 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 00:39:02 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 00:39:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:39:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:39:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:39:02 INFO - 'talos_options': ['--e10s'], 00:39:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:39:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:39:02 INFO - 'tests': ['damp', 'tps']}, 00:39:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:39:02 INFO - 'talos_options': ['--e10s'], 00:39:02 INFO - 'tests': ['damp', 'tps']}, 00:39:02 INFO - 'g3': {'tests': ['dromaeo_dom']}, 00:39:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:39:02 INFO - 'other': {'tests': ['a11yr', 00:39:02 INFO - 'ts_paint', 00:39:02 INFO - 'tpaint', 00:39:02 INFO - 'sessionrestore', 00:39:02 INFO - 'sessionrestore_no_auto_restore']}, 00:39:02 INFO - 'other-e10s': {'talos_options': ['--e10s'], 00:39:02 INFO - 'tests': ['a11yr', 00:39:02 INFO - 'ts_paint', 00:39:02 INFO - 'tpaint', 00:39:02 INFO - 'sessionrestore', 00:39:02 INFO - 'sessionrestore_no_auto_restore']}, 00:39:02 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 00:39:02 INFO - 'tests': ['a11yr', 00:39:02 INFO - 'ts_paint', 00:39:02 INFO - 'tpaint', 00:39:02 INFO - 'sessionrestore', 00:39:02 INFO - 'sessionrestore_no_auto_restore']}, 00:39:02 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 00:39:02 INFO - 'tests': ['a11yr', 00:39:02 INFO - 'ts_paint', 00:39:02 INFO - 'tpaint', 00:39:02 INFO - 'sessionrestore', 00:39:02 INFO - 'sessionrestore_no_auto_restore']}, 00:39:02 INFO - 'other_l64': {'tests': ['a11yr', 00:39:02 INFO - 'ts_paint', 00:39:02 INFO - 'tpaint', 00:39:02 INFO - 'sessionrestore', 00:39:02 INFO - 'sessionrestore_no_auto_restore']}, 00:39:02 INFO - 'other_nol64': {'tests': ['a11yr', 00:39:02 INFO - 'ts_paint', 00:39:02 INFO - 'tpaint', 00:39:02 INFO - 'sessionrestore', 00:39:02 INFO - 'sessionrestore_no_auto_restore']}, 00:39:02 INFO - 'svgr': {'tests': ['tsvgx', 00:39:02 INFO - 'tsvgr_opacity', 00:39:02 INFO - 'tart', 00:39:02 INFO - 'tscrollx', 00:39:02 INFO - 'cart']}, 00:39:02 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 00:39:02 INFO - 'tests': ['tsvgx', 00:39:02 INFO - 'tsvgr_opacity', 00:39:02 INFO - 'tart', 00:39:02 INFO - 'tscrollx', 00:39:02 INFO - 'cart']}, 00:39:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:39:02 INFO - 'tests': ['tp5o']}, 00:39:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:39:02 INFO - 'talos_options': ['--e10s'], 00:39:02 INFO - 'tests': ['tp5o']}, 00:39:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:39:02 INFO - 'talos_options': ['--xperf_path', 00:39:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:39:02 INFO - 'tests': ['tp5n']}, 00:39:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:39:02 INFO - 'talos_options': ['--e10s', 00:39:02 INFO - '--xperf_path', 00:39:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:39:02 INFO - 'tests': ['tp5n']}}, 00:39:02 INFO - 'talos.zip': {'path': '', 00:39:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:39:02 INFO - Running post-action listener: _resource_record_post_action 00:39:02 INFO - ##### 00:39:02 INFO - ##### Running create-virtualenv step. 00:39:02 INFO - ##### 00:39:02 INFO - Running pre-action listener: _resource_record_pre_action 00:39:02 INFO - Running main action method: create_virtualenv 00:39:02 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 00:39:02 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 00:39:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 00:39:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:39:02 INFO - Using real prefix '/usr' 00:39:02 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 00:39:02 INFO - Installing distribute.............................................................................................................................................................................................done. 00:39:04 INFO - Installing pip.................done. 00:39:04 INFO - Return code: 0 00:39:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 00:39:04 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')]} 00:39:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:39:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:39:04 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')]} 00:39:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:39:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:39:04 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 0x7f768cf84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ee2600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f71350>, '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 0x1f72250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f726e0>, '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': 'e10134013339c31d8d0c4708000001d6-1450233150.717384-950284369', '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 00:39:04 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 00:39:04 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 00:39:04 INFO - Using env: {'DISPLAY': ':0', 00:39:04 INFO - 'HOME': '/home/cltbld', 00:39:04 INFO - 'LANG': 'en_US.UTF-8', 00:39:04 INFO - 'LANGUAGE': 'en_US:en', 00:39:04 INFO - 'LOGNAME': 'cltbld', 00:39:04 INFO - 'MAIL': '/var/mail/cltbld', 00:39:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:39:04 INFO - 'MOZ_NO_REMOTE': '1', 00:39:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:39:04 INFO - 'NO_EM_RESTART': '1', 00:39:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:39:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:39:04 INFO - 'PWD': '/builds/slave/test-pgo', 00:39:04 INFO - 'SHELL': '/bin/bash', 00:39:04 INFO - 'SHLVL': '1', 00:39:04 INFO - 'TERM': 'linux', 00:39:04 INFO - 'TMOUT': '86400', 00:39:04 INFO - 'USER': 'cltbld', 00:39:04 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1450233150.717384-950284369', 00:39:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:39:04 INFO - '_': '/tools/buildbot/bin/python'} 00:39:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:39:05 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 00:39:05 INFO - Cleaning up... 00:39:05 INFO - Return code: 0 00:39:05 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 00:39: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')]} 00:39:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:39:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:39: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')]} 00:39:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:39:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:39:05 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f768cf84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ee2600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f71350>, '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 0x1f72250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f726e0>, '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': 'e10134013339c31d8d0c4708000001d6-1450233150.717384-950284369', '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 00:39:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 00:39:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 00:39:05 INFO - Using env: {'DISPLAY': ':0', 00:39:05 INFO - 'HOME': '/home/cltbld', 00:39:05 INFO - 'LANG': 'en_US.UTF-8', 00:39:05 INFO - 'LANGUAGE': 'en_US:en', 00:39:05 INFO - 'LOGNAME': 'cltbld', 00:39:05 INFO - 'MAIL': '/var/mail/cltbld', 00:39:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:39:05 INFO - 'MOZ_NO_REMOTE': '1', 00:39:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:39:05 INFO - 'NO_EM_RESTART': '1', 00:39:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:39:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:39:05 INFO - 'PWD': '/builds/slave/test-pgo', 00:39:05 INFO - 'SHELL': '/bin/bash', 00:39:05 INFO - 'SHLVL': '1', 00:39:05 INFO - 'TERM': 'linux', 00:39:05 INFO - 'TMOUT': '86400', 00:39:05 INFO - 'USER': 'cltbld', 00:39:05 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1450233150.717384-950284369', 00:39:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:39:05 INFO - '_': '/tools/buildbot/bin/python'} 00:39:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:39:05 INFO - Downloading/unpacking psutil>=0.7.1 00:39:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:39:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:39:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:39:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:39:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:39:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:39:06 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 00:39:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 00:39:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 00:39:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:39:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:39:07 INFO - Installing collected packages: psutil 00:39:07 INFO - Running setup.py install for psutil 00:39:07 INFO - building 'psutil._psutil_linux' extension 00:39:07 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 00:39:07 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 00:39:07 INFO - building 'psutil._psutil_posix' extension 00:39:07 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 00:39:07 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 00:39:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:39:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:39:07 INFO - Successfully installed psutil 00:39:07 INFO - Cleaning up... 00:39:07 INFO - Return code: 0 00:39:07 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 00:39:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:39:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:39:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:39:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:39:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:39:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:39:07 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 0x7f768cf84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ee2600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f71350>, '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 0x1f72250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f726e0>, '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': 'e10134013339c31d8d0c4708000001d6-1450233150.717384-950284369', '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 00:39:07 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 00:39:07 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 00:39:07 INFO - Using env: {'DISPLAY': ':0', 00:39:07 INFO - 'HOME': '/home/cltbld', 00:39:07 INFO - 'LANG': 'en_US.UTF-8', 00:39:07 INFO - 'LANGUAGE': 'en_US:en', 00:39:07 INFO - 'LOGNAME': 'cltbld', 00:39:07 INFO - 'MAIL': '/var/mail/cltbld', 00:39:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:39:07 INFO - 'MOZ_NO_REMOTE': '1', 00:39:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:39:07 INFO - 'NO_EM_RESTART': '1', 00:39:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:39:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:39:07 INFO - 'PWD': '/builds/slave/test-pgo', 00:39:07 INFO - 'SHELL': '/bin/bash', 00:39:07 INFO - 'SHLVL': '1', 00:39:07 INFO - 'TERM': 'linux', 00:39:07 INFO - 'TMOUT': '86400', 00:39:07 INFO - 'USER': 'cltbld', 00:39:07 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1450233150.717384-950284369', 00:39:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:39:07 INFO - '_': '/tools/buildbot/bin/python'} 00:39:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:39:07 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 00:39:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:39:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:39:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:39:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:39:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:39:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:39:09 INFO - Downloading mozsystemmonitor-0.0.tar.gz 00:39:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 00:39:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:39:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 00:39:09 INFO - Installing collected packages: mozsystemmonitor 00:39:09 INFO - Running setup.py install for mozsystemmonitor 00:39:09 INFO - Successfully installed mozsystemmonitor 00:39:09 INFO - Cleaning up... 00:39:09 INFO - Return code: 0 00:39:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 00:39: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')]} 00:39:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:39:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:39: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')]} 00:39:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:39:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:39: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', '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 0x7f768cf84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ee2600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f71350>, '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 0x1f72250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f726e0>, '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': 'e10134013339c31d8d0c4708000001d6-1450233150.717384-950284369', '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 00:39: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', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 00:39: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 blobuploader==1.2.4 00:39:09 INFO - Using env: {'DISPLAY': ':0', 00:39:09 INFO - 'HOME': '/home/cltbld', 00:39:09 INFO - 'LANG': 'en_US.UTF-8', 00:39:09 INFO - 'LANGUAGE': 'en_US:en', 00:39:09 INFO - 'LOGNAME': 'cltbld', 00:39:09 INFO - 'MAIL': '/var/mail/cltbld', 00:39:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:39:09 INFO - 'MOZ_NO_REMOTE': '1', 00:39:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:39:09 INFO - 'NO_EM_RESTART': '1', 00:39:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:39:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:39:09 INFO - 'PWD': '/builds/slave/test-pgo', 00:39:09 INFO - 'SHELL': '/bin/bash', 00:39:09 INFO - 'SHLVL': '1', 00:39:09 INFO - 'TERM': 'linux', 00:39:09 INFO - 'TMOUT': '86400', 00:39:09 INFO - 'USER': 'cltbld', 00:39:09 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1450233150.717384-950284369', 00:39:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:39:09 INFO - '_': '/tools/buildbot/bin/python'} 00:39:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:39:09 INFO - Downloading/unpacking blobuploader==1.2.4 00:39: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 00:39: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 00:39: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 00:39: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 00:39: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 00:39: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 00:39:11 INFO - Downloading blobuploader-1.2.4.tar.gz 00:39:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 00:39:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:39:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:39: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 00:39: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 00:39: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 00:39: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 00:39: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 00:39: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 00:39:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 00:39:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 00:39:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:39:12 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 00:39:12 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 00:39:12 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 00:39:12 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 00:39:12 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 00:39:12 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 00:39:12 INFO - Downloading docopt-0.6.1.tar.gz 00:39:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 00:39:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 00:39:12 INFO - Installing collected packages: blobuploader, requests, docopt 00:39:12 INFO - Running setup.py install for blobuploader 00:39:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:39:12 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 00:39:12 INFO - Running setup.py install for requests 00:39:12 INFO - Running setup.py install for docopt 00:39:12 INFO - Successfully installed blobuploader requests docopt 00:39:12 INFO - Cleaning up... 00:39:12 INFO - Return code: 0 00:39:12 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 00:39:12 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')]} 00:39:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:39:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:39:12 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')]} 00:39:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:39:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:39:12 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 0x7f768cf84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ee2600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f71350>, '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 0x1f72250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f726e0>, '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': 'e10134013339c31d8d0c4708000001d6-1450233150.717384-950284369', '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 00:39:12 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 00:39:12 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 00:39:12 INFO - Using env: {'DISPLAY': ':0', 00:39:12 INFO - 'HOME': '/home/cltbld', 00:39:12 INFO - 'LANG': 'en_US.UTF-8', 00:39:12 INFO - 'LANGUAGE': 'en_US:en', 00:39:12 INFO - 'LOGNAME': 'cltbld', 00:39:12 INFO - 'MAIL': '/var/mail/cltbld', 00:39:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:39:12 INFO - 'MOZ_NO_REMOTE': '1', 00:39:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:39:12 INFO - 'NO_EM_RESTART': '1', 00:39:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:39:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:39:12 INFO - 'PWD': '/builds/slave/test-pgo', 00:39:12 INFO - 'SHELL': '/bin/bash', 00:39:12 INFO - 'SHLVL': '1', 00:39:12 INFO - 'TERM': 'linux', 00:39:12 INFO - 'TMOUT': '86400', 00:39:12 INFO - 'USER': 'cltbld', 00:39:12 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1450233150.717384-950284369', 00:39:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:39:12 INFO - '_': '/tools/buildbot/bin/python'} 00:39:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:39:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 00:39:13 INFO - Running setup.py (path:/tmp/pip-iAN3WA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 00:39:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 00:39:13 INFO - Running setup.py (path:/tmp/pip-85A8uh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 00:39:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 00:39:13 INFO - Running setup.py (path:/tmp/pip-BMWj6A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 00:39:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 00:39:13 INFO - Running setup.py (path:/tmp/pip-5U51ax-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 00:39:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 00:39:13 INFO - Running setup.py (path:/tmp/pip-mohs_Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 00:39:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 00:39:13 INFO - Running setup.py (path:/tmp/pip-CQ4dn3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 00:39:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 00:39:13 INFO - Running setup.py (path:/tmp/pip-sdfbPL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 00:39:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 00:39:13 INFO - Running setup.py (path:/tmp/pip-UZwwpA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 00:39:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 00:39:13 INFO - Running setup.py (path:/tmp/pip-hMoM7t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 00:39:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 00:39:13 INFO - Running setup.py (path:/tmp/pip-Sz6SFi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 00:39:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 00:39:13 INFO - Running setup.py (path:/tmp/pip-P7Bwvc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 00:39:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 00:39:13 INFO - Running setup.py (path:/tmp/pip-fxJR4o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 00:39:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 00:39:13 INFO - Running setup.py (path:/tmp/pip-EPgClz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 00:39:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 00:39:14 INFO - Running setup.py (path:/tmp/pip-g07_ff-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 00:39:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 00:39:14 INFO - Running setup.py (path:/tmp/pip-ZoxHFN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 00:39:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 00:39:14 INFO - Running setup.py (path:/tmp/pip-kae2c6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 00:39:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 00:39:14 INFO - Running setup.py (path:/tmp/pip-dpIGtV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 00:39:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:39:14 INFO - Running setup.py install for manifestparser 00:39:14 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 00:39:14 INFO - Running setup.py install for mozcrash 00:39:14 INFO - Running setup.py install for mozdebug 00:39:14 INFO - Running setup.py install for mozdevice 00:39:14 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 00:39:14 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 00:39:14 INFO - Running setup.py install for mozfile 00:39:14 INFO - Running setup.py install for mozhttpd 00:39:14 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 00:39:14 INFO - Running setup.py install for mozinfo 00:39:15 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 00:39:15 INFO - Running setup.py install for mozInstall 00:39:15 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 00:39:15 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 00:39:15 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 00:39:15 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 00:39:15 INFO - Running setup.py install for mozleak 00:39:15 INFO - Running setup.py install for mozlog 00:39:15 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 00:39:15 INFO - Running setup.py install for moznetwork 00:39:15 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 00:39:15 INFO - Running setup.py install for mozprocess 00:39:15 INFO - Running setup.py install for mozprofile 00:39:15 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 00:39:15 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 00:39:15 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 00:39:15 INFO - Running setup.py install for mozrunner 00:39:15 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 00:39:15 INFO - Running setup.py install for mozscreenshot 00:39:15 INFO - Running setup.py install for moztest 00:39:15 INFO - Running setup.py install for mozversion 00:39:16 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 00:39:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:39:16 INFO - Cleaning up... 00:39:16 INFO - Return code: 0 00:39:16 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 00:39:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:39:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:39:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:39:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:39:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:39:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:39:16 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7f768cf84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ee2600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f71350>, '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 0x1f72250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f726e0>, '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': 'e10134013339c31d8d0c4708000001d6-1450233150.717384-950284369', '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 00:39:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 00:39:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/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 00:39:16 INFO - Using env: {'DISPLAY': ':0', 00:39:16 INFO - 'HOME': '/home/cltbld', 00:39:16 INFO - 'LANG': 'en_US.UTF-8', 00:39:16 INFO - 'LANGUAGE': 'en_US:en', 00:39:16 INFO - 'LOGNAME': 'cltbld', 00:39:16 INFO - 'MAIL': '/var/mail/cltbld', 00:39:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:39:16 INFO - 'MOZ_NO_REMOTE': '1', 00:39:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:39:16 INFO - 'NO_EM_RESTART': '1', 00:39:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:39:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:39:16 INFO - 'PWD': '/builds/slave/test-pgo', 00:39:16 INFO - 'SHELL': '/bin/bash', 00:39:16 INFO - 'SHLVL': '1', 00:39:16 INFO - 'TERM': 'linux', 00:39:16 INFO - 'TMOUT': '86400', 00:39:16 INFO - 'USER': 'cltbld', 00:39:16 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1450233150.717384-950284369', 00:39:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:39:16 INFO - '_': '/tools/buildbot/bin/python'} 00:39:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:39:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 00:39:16 INFO - Running setup.py (path:/tmp/pip-EQiIQy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 00:39:16 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)) 00:39:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 00:39:16 INFO - Running setup.py (path:/tmp/pip-_sVn3R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 00:39:16 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)) 00:39:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 00:39:16 INFO - Running setup.py (path:/tmp/pip-LTgnrU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 00:39:16 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)) 00:39:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 00:39:16 INFO - Running setup.py (path:/tmp/pip-LToCnP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 00:39:16 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)) 00:39:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 00:39:16 INFO - Running setup.py (path:/tmp/pip-0hbCTa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 00:39:16 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)) 00:39:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 00:39:16 INFO - Running setup.py (path:/tmp/pip-x3a9LO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 00:39:16 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)) 00:39:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 00:39:16 INFO - Running setup.py (path:/tmp/pip-Pyg4P6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 00:39:16 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)) 00:39:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 00:39:16 INFO - Running setup.py (path:/tmp/pip-UQRPKv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 00:39:16 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)) 00:39:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 00:39:16 INFO - Running setup.py (path:/tmp/pip-mc3Sd5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 00:39:16 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)) 00:39:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 00:39:16 INFO - Running setup.py (path:/tmp/pip-DKRfrI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 00:39:17 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)) 00:39:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 00:39:17 INFO - Running setup.py (path:/tmp/pip-eZLrdj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 00:39:17 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)) 00:39:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 00:39:17 INFO - Running setup.py (path:/tmp/pip-LGZcCf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 00:39:17 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)) 00:39:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 00:39:17 INFO - Running setup.py (path:/tmp/pip-qZyOXA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 00:39:17 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)) 00:39:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 00:39:17 INFO - Running setup.py (path:/tmp/pip-ymDMfy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 00:39:17 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)) 00:39:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 00:39:17 INFO - Running setup.py (path:/tmp/pip-IQ6fgr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 00:39:17 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)) 00:39:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 00:39:17 INFO - Running setup.py (path:/tmp/pip-67j5IP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 00:39:17 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)) 00:39:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 00:39:17 INFO - Running setup.py (path:/tmp/pip-HMLXla-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 00:39:17 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)) 00:39:17 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)) 00:39:17 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)) 00:39:17 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)) 00:39:17 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)) 00:39:17 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)) 00:39:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 00:39:17 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 00:39:17 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 00:39:17 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 00:39:17 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 00:39:17 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 00:39:17 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 00:39:19 INFO - Downloading blessings-1.5.1.tar.gz 00:39:19 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 00:39:19 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 00:39:19 INFO - Installing collected packages: blessings 00:39:19 INFO - Running setup.py install for blessings 00:39:19 INFO - Successfully installed blessings 00:39:19 INFO - Cleaning up... 00:39:19 INFO - Return code: 0 00:39:19 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 00:39:19 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 00:39:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 00:39:19 INFO - Reading from file tmpfile_stdout 00:39:19 INFO - Current package versions: 00:39:19 INFO - argparse == 1.2.1 00:39:19 INFO - blessings == 1.5.1 00:39:19 INFO - blobuploader == 1.2.4 00:39:19 INFO - docopt == 0.6.1 00:39:19 INFO - manifestparser == 1.1 00:39:19 INFO - mozInstall == 1.12 00:39:19 INFO - mozcrash == 0.16 00:39:19 INFO - mozdebug == 0.1 00:39:19 INFO - mozdevice == 0.46 00:39:19 INFO - mozfile == 1.2 00:39:19 INFO - mozhttpd == 0.7 00:39:19 INFO - mozinfo == 0.8 00:39:19 INFO - mozleak == 0.1 00:39:19 INFO - mozlog == 3.0 00:39:19 INFO - moznetwork == 0.27 00:39:19 INFO - mozprocess == 0.22 00:39:19 INFO - mozprofile == 0.27 00:39:19 INFO - mozrunner == 6.11 00:39:19 INFO - mozscreenshot == 0.1 00:39:19 INFO - mozsystemmonitor == 0.0 00:39:19 INFO - moztest == 0.7 00:39:19 INFO - mozversion == 1.4 00:39:19 INFO - psutil == 3.1.1 00:39:19 INFO - requests == 1.2.3 00:39:19 INFO - wsgiref == 0.1.2 00:39:19 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 00:39:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:39:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:39:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:39:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:39:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:39:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:39:19 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f768cf84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ee2600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f71350>, '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 0x1f72250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f726e0>, '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': 'e10134013339c31d8d0c4708000001d6-1450233150.717384-950284369', '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 00:39:19 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 00:39:19 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 00:39:19 INFO - Using env: {'DISPLAY': ':0', 00:39:19 INFO - 'HOME': '/home/cltbld', 00:39:19 INFO - 'LANG': 'en_US.UTF-8', 00:39:19 INFO - 'LANGUAGE': 'en_US:en', 00:39:19 INFO - 'LOGNAME': 'cltbld', 00:39:19 INFO - 'MAIL': '/var/mail/cltbld', 00:39:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:39:19 INFO - 'MOZ_NO_REMOTE': '1', 00:39:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:39:19 INFO - 'NO_EM_RESTART': '1', 00:39:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:39:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:39:19 INFO - 'PWD': '/builds/slave/test-pgo', 00:39:19 INFO - 'SHELL': '/bin/bash', 00:39:19 INFO - 'SHLVL': '1', 00:39:19 INFO - 'TERM': 'linux', 00:39:19 INFO - 'TMOUT': '86400', 00:39:19 INFO - 'USER': 'cltbld', 00:39:19 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1450233150.717384-950284369', 00:39:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:39:19 INFO - '_': '/tools/buildbot/bin/python'} 00:39:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:39:19 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)) 00:39:19 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)) 00:39:19 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)) 00:39:19 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)) 00:39:19 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)) 00:39:19 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)) 00:39:19 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)) 00:39:19 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)) 00:39:19 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)) 00:39:19 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)) 00:39:19 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)) 00:39:19 INFO - Cleaning up... 00:39:19 INFO - Return code: 0 00:39:19 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 00:39:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:39:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:39:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:39:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:39:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:39:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:39:19 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f768cf84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ee2600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f71350>, '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 0x1f72250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f726e0>, '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': 'e10134013339c31d8d0c4708000001d6-1450233150.717384-950284369', '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 00:39:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 00:39:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 00:39:19 INFO - Using env: {'DISPLAY': ':0', 00:39:19 INFO - 'HOME': '/home/cltbld', 00:39:19 INFO - 'LANG': 'en_US.UTF-8', 00:39:19 INFO - 'LANGUAGE': 'en_US:en', 00:39:19 INFO - 'LOGNAME': 'cltbld', 00:39:19 INFO - 'MAIL': '/var/mail/cltbld', 00:39:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:39:19 INFO - 'MOZ_NO_REMOTE': '1', 00:39:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:39:19 INFO - 'NO_EM_RESTART': '1', 00:39:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:39:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:39:19 INFO - 'PWD': '/builds/slave/test-pgo', 00:39:19 INFO - 'SHELL': '/bin/bash', 00:39:19 INFO - 'SHLVL': '1', 00:39:19 INFO - 'TERM': 'linux', 00:39:19 INFO - 'TMOUT': '86400', 00:39:19 INFO - 'USER': 'cltbld', 00:39:19 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1450233150.717384-950284369', 00:39:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:39:19 INFO - '_': '/tools/buildbot/bin/python'} 00:39:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:39:20 INFO - Downloading/unpacking jsonschema 00:39:20 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 00:39:20 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 00:39:20 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 00:39:20 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 00:39:20 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 00:39:20 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 00:39:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:39:21 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 00:39:21 INFO - Downloading/unpacking functools32 (from jsonschema) 00:39:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:39:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:39:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:39:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:39:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:39:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:39:22 INFO - Downloading functools32-3.2.3-2.tar.gz 00:39:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 00:39:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 00:39:22 INFO - warning: no files found matching '*.txt' 00:39:22 INFO - no previously-included directories found matching 'build' 00:39:22 INFO - no previously-included directories found matching 'dist' 00:39:22 INFO - no previously-included directories found matching '.git*' 00:39:22 INFO - Installing collected packages: jsonschema, functools32 00:39:22 INFO - Running setup.py install for functools32 00:39:22 INFO - warning: no files found matching '*.txt' 00:39:22 INFO - no previously-included directories found matching 'build' 00:39:22 INFO - no previously-included directories found matching 'dist' 00:39:22 INFO - no previously-included directories found matching '.git*' 00:39:22 INFO - Successfully installed jsonschema functools32 00:39:22 INFO - Cleaning up... 00:39:22 INFO - Return code: 0 00:39:22 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 00:39:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:39:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:39:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:39:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:39:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:39:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:39:22 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 0x7f768cf84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ee2600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f71350>, '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 0x1f72250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f726e0>, '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': 'e10134013339c31d8d0c4708000001d6-1450233150.717384-950284369', '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 00:39:22 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 00:39:22 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 00:39:22 INFO - Using env: {'DISPLAY': ':0', 00:39:22 INFO - 'HOME': '/home/cltbld', 00:39:22 INFO - 'LANG': 'en_US.UTF-8', 00:39:22 INFO - 'LANGUAGE': 'en_US:en', 00:39:22 INFO - 'LOGNAME': 'cltbld', 00:39:22 INFO - 'MAIL': '/var/mail/cltbld', 00:39:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:39:22 INFO - 'MOZ_NO_REMOTE': '1', 00:39:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:39:22 INFO - 'NO_EM_RESTART': '1', 00:39:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:39:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:39:22 INFO - 'PWD': '/builds/slave/test-pgo', 00:39:22 INFO - 'SHELL': '/bin/bash', 00:39:22 INFO - 'SHLVL': '1', 00:39:22 INFO - 'TERM': 'linux', 00:39:22 INFO - 'TMOUT': '86400', 00:39:22 INFO - 'USER': 'cltbld', 00:39:22 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1450233150.717384-950284369', 00:39:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:39:22 INFO - '_': '/tools/buildbot/bin/python'} 00:39:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:39:22 INFO - Downloading/unpacking flake8 00:39:22 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 00:39:22 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 00:39:22 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 00:39:22 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 00:39:22 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 00:39:22 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 00:39:24 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 00:39:24 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 00:39:24 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 00:39:24 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 00:39:24 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 00:39:24 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 00:39:24 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 00:39:24 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 00:39:24 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 00:39:24 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 00:39:24 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 00:39:24 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 00:39:24 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 00:39:24 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 00:39:24 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 00:39:24 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 00:39:24 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 00:39:24 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 00:39:24 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 00:39:24 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 00:39:24 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 00:39:24 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 00:39:24 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 00:39:24 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 00:39:24 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 00:39:24 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 00:39:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 00:39:24 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 00:39:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:39:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:39:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:39:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:39:24 INFO - no previously-included directories found matching 'docs/_build' 00:39:24 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 00:39:25 INFO - Running setup.py install for pep8 00:39:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:39:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:39:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:39:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:39:25 INFO - no previously-included directories found matching 'docs/_build' 00:39:25 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 00:39:25 INFO - Successfully installed flake8 mccabe pyflakes pep8 00:39:25 INFO - Cleaning up... 00:39:25 INFO - Return code: 0 00:39:25 INFO - Running post-action listener: _resource_record_post_action 00:39:25 INFO - Running post-action listener: _start_resource_monitoring 00:39:25 INFO - Starting resource monitoring. 00:39:25 INFO - ##### 00:39:25 INFO - ##### Running install step. 00:39:25 INFO - ##### 00:39:25 INFO - Running pre-action listener: _resource_record_pre_action 00:39:25 INFO - Running main action method: install 00:39:25 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 00:39:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 00:39:25 INFO - Reading from file tmpfile_stdout 00:39:25 INFO - Detecting whether we're running mozinstall >=1.0... 00:39:25 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 00:39:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 00:39:25 INFO - Reading from file tmpfile_stdout 00:39:25 INFO - Output received: 00:39:25 INFO - Usage: mozinstall [options] installer 00:39:25 INFO - Options: 00:39:25 INFO - -h, --help show this help message and exit 00:39:25 INFO - -d DEST, --destination=DEST 00:39:25 INFO - Directory to install application into. [default: 00:39:25 INFO - "/builds/slave/test-pgo"] 00:39:25 INFO - --app=APP Application being installed. [default: firefox] 00:39:25 INFO - mkdir: /builds/slave/test-pgo/build/application 00:39:25 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'] 00:39:25 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 00:39:39 INFO - Reading from file tmpfile_stdout 00:39:39 INFO - Output received: 00:39:39 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 00:39:39 INFO - Running post-action listener: _resource_record_post_action 00:39:39 INFO - ##### 00:39:39 INFO - ##### Running run-tests step. 00:39:39 INFO - ##### 00:39:39 INFO - Running pre-action listener: _resource_record_pre_action 00:39:39 INFO - Running main action method: run_tests 00:39:39 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 00:39:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 00:39:39 INFO - Python 2.7.3 00:39:39 INFO - Return code: 0 00:39:39 INFO - grabbing minidump binary from tooltool 00:39:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:39:39 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 0x1f71350>, '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 0x1f72250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f726e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 00:39:39 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 00:39:39 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 00:39:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:39:39 INFO - Return code: 0 00:39:39 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 00:39:39 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 00:39:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 00:39:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 00:39:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 00:39:39 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 00:39:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 00:39:40 INFO - Return code: 0 00:39:40 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/1450246929/firefox-44.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 00:39:40 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/1450246929/firefox-44.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --webServer localhost 00:39:40 INFO - Using env: {'DISPLAY': ':0', 00:39:40 INFO - 'HOME': '/home/cltbld', 00:39:40 INFO - 'LANG': 'en_US.UTF-8', 00:39:40 INFO - 'LANGUAGE': 'en_US:en', 00:39:40 INFO - 'LOGNAME': 'cltbld', 00:39:40 INFO - 'MAIL': '/var/mail/cltbld', 00:39:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 00:39:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 00:39:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:39:40 INFO - 'MOZ_NO_REMOTE': '1', 00:39:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 00:39:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:39:40 INFO - 'NO_EM_RESTART': '1', 00:39:40 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:39:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:39:40 INFO - 'PWD': '/builds/slave/test-pgo', 00:39:40 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 00:39:40 INFO - 'SHELL': '/bin/bash', 00:39:40 INFO - 'SHLVL': '1', 00:39:40 INFO - 'TERM': 'linux', 00:39:40 INFO - 'TMOUT': '86400', 00:39:40 INFO - 'USER': 'cltbld', 00:39:40 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1450233150.717384-950284369', 00:39:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:39:40 INFO - '_': '/tools/buildbot/bin/python'} 00:39:40 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/1450246929/firefox-44.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost'] with output_timeout 3600 00:39:41 INFO - mozversion INFO | application_buildid: 20151215222209 00:39:41 INFO - mozversion INFO | application_changeset: b2d75585bfc485f884f2822b0541f694b069d87c 00:39:41 INFO - mozversion INFO | application_display_name: Nightly 00:39:41 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:39:41 INFO - mozversion INFO | application_name: Firefox 00:39:41 INFO - mozversion INFO | application_remotingname: firefox 00:39:41 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-beta 00:39:41 INFO - mozversion INFO | application_vendor: Mozilla 00:39:41 INFO - mozversion INFO | application_version: 44.0 00:39:41 INFO - mozversion INFO | platform_buildid: 20151215222209 00:39:41 INFO - mozversion INFO | platform_changeset: b2d75585bfc485f884f2822b0541f694b069d87c 00:39:41 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-beta 00:39:41 INFO - mozversion INFO | platform_version: 44.0 00:39:41 INFO - 2015-12-16 00:39:41,019 DEBUG : using testdate: 1450255181 00:39:41 INFO - 2015-12-16 00:39:41,019 DEBUG : actual date: 1450255181 00:39:41 INFO - 2015-12-16 00:39:41,107 INFO : starting webserver on 'localhost:44667' 00:39:41 INFO - 2015-12-16 00:39:41,108 INFO : Starting test suite talos-linux64-ix-023 00:39:41 INFO - 2015-12-16 00:39:41,108 INFO : Starting test dromaeo_css 00:39:41 INFO - 2015-12-16 00:39:41,108 DEBUG : operating with platform_type : linux_ 00:39:41 INFO - 2015-12-16 00:39:41,109 INFO : Initialising browser for dromaeo_css test... 00:39:41 INFO - 2015-12-16 00:39:41,125 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKBYs2E/profile http://localhost:44667/getInfo.html 00:39:45 INFO - 2015-12-16 00:39:45,228 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 00:39:45 INFO - 2015-12-16 00:39:45,228 DEBUG : BROWSER_OUTPUT: colorDepth:24 00:39:45 INFO - 2015-12-16 00:39:45,228 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 00:39:45 INFO - 2015-12-16 00:39:45,228 DEBUG : BROWSER_OUTPUT: __metrics 00:39:45 INFO - 2015-12-16 00:39:45,345 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] 00:39:46 INFO - 2015-12-16 00:39:46,545 INFO : Browser initialized. 00:39:46 INFO - 2015-12-16 00:39:46,545 INFO : Running cycle 1/1 for dromaeo_css test... 00:39:46 INFO - 2015-12-16 00:39:46,546 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKBYs2E/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 00:39:58 INFO - 2015-12-16 00:39:58,222 DEBUG : BROWSER_OUTPUT: RSS: Main: 131870720 00:39:58 INFO - 2015-12-16 00:39:58,222 DEBUG : BROWSER_OUTPUT: 00:40:49 INFO - 2015-12-16 00:40:49,137 DEBUG : BROWSER_OUTPUT: 1450255249130 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] 00:42:57 INFO - 2015-12-16 00:42:57,018 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44667/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44667/tests/dromaeo/cssquery-ext.html) 00:42:58 INFO - 2015-12-16 00:42:58,107 DEBUG : BROWSER_OUTPUT: RSS: Main: 239669248 00:42:58 INFO - 2015-12-16 00:42:58,107 DEBUG : BROWSER_OUTPUT: 00:46:00 INFO - 2015-12-16 00:46:00,158 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44667/tests/dromaeo/cssquery-ext.html (next: http://localhost:44667/tests/dromaeo/cssquery-jquery.html) 00:46:00 INFO - 2015-12-16 00:46:00,719 DEBUG : BROWSER_OUTPUT: RSS: Main: 212140032 00:46:00 INFO - 2015-12-16 00:46:00,720 DEBUG : BROWSER_OUTPUT: 00:49:02 INFO - 2015-12-16 00:49:02,409 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44667/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44667/tests/dromaeo/cssquery-mootools.html) 00:49:02 INFO - 2015-12-16 00:49:02,970 DEBUG : BROWSER_OUTPUT: RSS: Main: 207663104 00:49:02 INFO - 2015-12-16 00:49:02,971 DEBUG : BROWSER_OUTPUT: 00:52:04 INFO - 2015-12-16 00:52:04,618 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44667/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44667/tests/dromaeo/cssquery-prototype.html) 00:52:05 INFO - 2015-12-16 00:52:05,190 DEBUG : BROWSER_OUTPUT: RSS: Main: 191455232 00:52:05 INFO - 2015-12-16 00:52:05,190 DEBUG : BROWSER_OUTPUT: 00:55:07 INFO - 2015-12-16 00:55:07,457 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44667/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44667/tests/dromaeo/cssquery-yui.html) 00:55:08 INFO - 2015-12-16 00:55:08,018 DEBUG : BROWSER_OUTPUT: RSS: Main: 197337088 00:55:08 INFO - 2015-12-16 00:55:08,019 DEBUG : BROWSER_OUTPUT: 00:58:10 INFO - 2015-12-16 00:58:10,308 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44667/tests/dromaeo/cssquery-yui.html (next: http://localhost:44667/tests/dromaeo/cssquery-dojo.html) 00:58:10 INFO - 2015-12-16 00:58:10,552 DEBUG : BROWSER_OUTPUT: RSS: Main: 211017728 00:58:10 INFO - 2015-12-16 00:58:10,552 DEBUG : BROWSER_OUTPUT: 00:58:10 INFO - 2015-12-16 00:58:10,553 DEBUG : BROWSER_OUTPUT: __start_tp_report 00:58:10 INFO - 2015-12-16 00:58:10,554 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 00:58:10 INFO - 2015-12-16 00:58:10,554 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 00:58:10 INFO - 2015-12-16 00:58:10,554 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 00:58:10 INFO - 2015-12-16 00:58:10,557 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3322.3355328934213;3372.6121496027963;3393.457046872501;3403.1322012886712;3416.1630400551862;5616.438356164382;5623.550115990721;5633.380328163898;5640.9999999999945;5642.774289028444;5649.717514124298;5653;5657.462541058603;5667.886642267152;5669.149627555868;4950.183219768734;5128.410232823227;5138.820141295056;5205.86985325368;5229.555487783543;5118.820841270556;5121.411037730652;5203.19350500673;5223.817166399177;5226.372835259775;5178.66338687986;5212.687238765668;5219.660722053073;5221.451747566508;5240.9213861792105;4943.777530011158;5142.7685754140775;5146;5219.73901304937;5226.947730522684;4980.601551875841;4991.376077990251;5111.974440127813;5117.948820511784;5144.382674079097;5386.91919621206;5459.563234941195;5470.671759694431;5484.232207490954;5485;5914.763409463616;6036.305824830157;6115.6942152892625;6131.96934015327;6134.478569321613;5907.6750778707155;6018.21763170785;6022.789202377896;6026.427489388501;6032.336442991267;5644.435556444323;5646.632968857011;5648.124540696199;5659.886802263973;5751.223584816038;6011.909821352683;6070.544709146831;6079.209702738615;6096.69516524172;6112.633242005494;5985.34161242263;5993.640381577119;5993.820185394445;5995.760169593167;6009.429104235091;6063.969680151571;6069.544784141207;6073.18012068374;6080.118382834465;6085.421884920926;5968;6008.639481631116;6037.45662890342;6038.728257228435;6142.416470435302;6106.572539922163;6109.266887973472;6117.571769976148;6119.082137679384;6119.296280927661;4657.464391594942;4663.650226233046;4665.183592871234;4668.206404911105;4684.906301873943;3987.3420885554137;4067;4085.4076158956786;4185.811638476276;4192.014876504019;5789.8263052108505;5816.127580862904;5822.7670893163795;5822.912656310159;5823.56323275756;5973.910391344133;6156.29202641693;6181.134641150243;6184.5052395808225;6197.070439434031;5568.3318001839225;5663.405342438985;5683;5704.71476426177;5731.340895797037;5266.578673706094;5298.947010529922;5310.442403547572;5314.335708036496;5314.946850531523;6013.188219590299;6103.115048317969;6269.905951410641;6283.214598175228;6287.591306565058;5947.762089516371;5949.702514874152;5961.076033214858;5989;5991.101334799815;6236.376362363727;6240.188775459162;6241.375862413723;6246.562740608114;6246.750129994749;5790.10253410722;5892.911606325994;5954.404559544011;6007.158997740407;6038.094285857156;6060.363661815446;6070.848228794139;6076.453119219114;6078.270607527125;6089.056196289582;5885.47030767233;5888.352281249145;5906.911396328973;5913.674747888907;5951.791687290924;5744.770209191585;5848.473637372657;5889.617174883619;5966.731497082555;6007.8197654070445;5842.269716285465;5846.853828654318;5849.736761845642;5852.356240813592;5854.824355269178;5881.970590147193;5947.226860508279;5950;5962.046072628359;5963.224780778471;5762.6830524319885;5767.942320576741;5859;5871.853203669943;5888.3228428731245 00:58:10 INFO - 2015-12-16 00:58:10,558 DEBUG : BROWSER_OUTPUT: |1;ext.html;578.1443463673763;615.664462867737;624.8719012602415;653.5457856789527;656.3305428462965;35094.8245258774;43021.35467967979;43657;43881.12237755243;43883.561164388346;46887.76556117215;47504.28743568849;47509.28736068962;47586.52413475864;47593.524064759345;7949;8062.71780487683;9097.13577210164;9284;10672.839907401396;10949.288296260758;11083.556657733681;11093.168012399063;11093.944530277337;11097.16771242156;10988.890111098906;11049.613263535777;11087.55649774008;11105.666829995072;11108.16688748343;10931.234813563055;11044.613438529654;11050.502727377287;11051.281666691679;11057.170712196537;10544.578216871316;10728.302660327132;10742.194335424796;10785.730356741065;10788.298760580537;43330.35004474936;43804.342934856;43839;43898.34152487715;43907.12185756267;3397.269587038774;3538.752287339887;3568.1436455250814;3663.8900832975055;3700.833462494194;28881.711182888113;28916.566251506243;29223.39348163387;29240.853795730884;29878.25304367408;3897.7856217908;3983.5817239190046;3991.900202494932;4011.8997025074314;4089.0390758171807;325432;325641;325803;325818;326798;58816.705916471;59985.70007149936;64572.354276457576;65032;69386.65306673535;50925.745371272904;51025.234621480704;51088;51138.74430627823;51209.48790512047;17533.386331478338;17799.644007119787;17812.10939453022;17814.821851781577;17827.197776100107;14637.560873173821;14717.55847324582;14743.705125897422;14767.556973290819;14820.481283155254;20608.690869636666;20942.47643808917;20958.685619715718;21017.474563136046;21058.684119738216;7620.5808680523105;7994.680212791423;8014.559199243981;8061.2744852963515;8102.594870256464;915.7481692534473;940.971770846862;983.8671779309844;1118.7426891814928;1121.3664279681955;30637;30829.691703083132;31114;31452.842735786173;31859.36281274408;1103.8289065194908;1129.7909886670993;1135.6888731431497;1150.9123877935272;1174.453878946294;14095.859041409454;14701;14758.852411475962;15186.164760938254;16362.018278903304;383660;388556;390969;393904;395305;51790.482095178566;51861.740691297055;56532.434675652716;58452;59015.40984590185;1318.7098838255567;1470.147314557554;1472.3595236072129;1480.7334679757746;1516.2494565190082;24262.393440164138;24393.634095488225;24470.755292446847;24627.13805016816;24628;44706.55293447024;45020.32469513026;45129;45134.09731805411;45150.77424612856;316207;317926;318490;318907;319271;35249.471257930636;35280;35752.64247357493;35818.82090589635;35924.28151437009;46585;46813.29780053234;47382.52617473781;47682.761586191846;47712.28431573599;37939;38421.4236786454;39572.20855582815;39841.80079099586;39909.60090399175;40837.38743918903;41629.37555936724;42125.789371052946;42225.36661950012;43314;38685;39631;39668.40497392484;39686.404703928885;39753.60246397499;34286.314273713884;34561.65438345685;35264.29471410506;35832.820835895654;35971.640283596826;22849.771502284766;23846.52306953886;24314.513709725354;35422;35535.64464355427 00:58:10 INFO - 2015-12-16 00:58:10,559 DEBUG : BROWSER_OUTPUT: |2;jquery.html;390.9824057917393;394.34341820868246;394.3552292002575;395.55895176877755;399.20956506117886;13102.213867167953;14790.852091479082;18837.81162188378;20713.68929466059;20720.171193152255;19635.705464418046;19635.803641963576;19649.803501964976;19655.606887862235;19707.211711531523;5963.791267305634;6019.337872833985;6075;6075;6094.664793436359;5876.382979787125;5985.072313791369;6018.969905150469;6030.728617212236;6035.728392222339;4426.712263702865;4552.08958208358;5972.820815375546;5979.730912108944;5983.072623743326;6430.742770289183;6523.739050437976;6592.077109204715;6617.966910165443;6621.867562648744;5762.942370576325;5865.149553314788;5897.941020589782;5909.113632955048;5909.556783241274;14724.705505889822;22638.66042009371;22959.77040229593;23173;23268.65097023546;2104.600125976075;2131.0516820014946;2190.452386903274;2192.8793916334594;2196.2642514757417;10304.536295866628;10396.688099357032;10576.206784491194;10593.84109238362;10713.196510261683;1784.286285485803;1840.3282801777389;1843;1863.170888954416;1881.868269221155;66018.3398166017;66896;66997;67300;67396.6630166851;7891.526508409514;7934.20657934202;8015.398845086642;8044.074931382849;8080.030396352476;9740.074692904163;9740.17208537268;9740.172085372822;9742.75643108928;9745.512724363753;6392.680365981682;6531.8693626127215;6560.114384558119;6570.211574611078;6582.506312026521;6561.901571476432;6583.868322633521;6622.37087476689;6743.15710536183;6825.55633883796;3687.9262414751556;3710.0539362462937;3715.461258117558;3739.719521035933;3754.962450375516;1183.556166437586;1224.8040313549789;1268.5750273658243;1304.2565737529708;1315.7105436803888;497.19950879084644;499.7626127589366;507.6192855358481;519.125273913457;519.3404376441898;11364.772704546029;13331.533396331082;13482.932585337207;13577.864221357857;13894.305284735925;529.7960285290114;533.5038414274684;537.8870437208152;541.4882935625875;555.9908765590441;5367.704776237344;7155.642217889084;7342.4493163012985;7366.226546212678;7372.96313518429;466018;477304;613571;621174;628796;73484.63257683677;76053;76069.23930760621;76374.61812690902;77020;587.4096532984323;595.7637901354619;601.8044135655929;603.0200923499314;604.2778879239355;11865.228760130563;11924.523019079139;12009.279443233434;12029.097817663886;12037.277763333877;35775.284494309446;39269.803650981565;39389.80305098456;40840.183196336504;41014.38478422767;51896.74051629718;52962.73853397922;53661.19508207302;53778;54035;7521.548707077593;7640.617969101634;7708.344790692854;8019.358451323997;8024.398170137147;12864.614061578168;13732.862671373558;14229.075110117808;14268.286585670883;14338.354774034984;11449.198556101326;11500.53997840077;11796.646100616996;12199.329036903055;12202.450889709808;11744.94127529357;11746;11794.351310677996;11845.11161662896;11863.940680296544;9447.574859131493;10090.798184036425;10211.84682229782;12174.026077913568;12241.938790305992;7614.16244213125;7699.769006929801;7717.344025757873;7816.960915195615;7852.136265010959;11739.706507337385;11837;12026.75946481083;12182.695432614255;12581.245125292511 00:58:10 INFO - 2015-12-16 00:58:10,560 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1384.1556650443229;1385.8198434203553;1456.4028748213234;1827.734978428127;1847.270328220353;7188.317109874553;7354.963225183867;8052.919470805297;8239.176082391758;8247.793805154866;7645.770626881203;7830.373570114377;7901.407394445411;7903.604819759018;7909.683612655487;2369.9763002370014;2406.254061241012;2407.9157229496973;2408.1812183857487;2408.385861605297;2108.9789102108934;2142.464383904024;2326.09282379872;2355.3287313115766;2374.8218883583713;2352.6706261123454;2360.905563777447;2366.3610825077303;2367.337145599235;2390.032037025008;2395.4849707312924;2422.2854257993936;2426.9271921842374;2428.538577670237;2428.647846062329;2366.6568347589673;2420;2427.538767634144;2431.258466167818;2432.1487479382254;7908.130105688369;7983.8403231935035;7996.480228785169;7998.920010799934;8001.19988001201;4900.068986892479;4929.408470983505;4975.253711943237;4976.253561965698;4976.975115124437;3302.78531895426;3331.25046864456;3339.699427051553;3368.225308179108;3374.746893982961;1202.4468744377598;1212.8847759462926;1238.9876101238963;1254.7866862633375;1268.758935802204;10689.091427228695;10707.518161682743;10715.732106697316;10728.141748660088;10740.677779666623;4653.790579423934;4687.039156972813;4688.343631891538;4721.6694831362165;4731.597814185764;9542.236621070298;9549;9560.187384072293;9562.378445401027;9567.61729530825;4954.900901982012;4960.875978100504;4963.081829861487;4963.851084467472;4967.776450059684;4466.4640243171025;4505.256632655575;4505.797239124247;4505.977470112629;4509.120721459284;3657.7073834093208;3980;4001.139754952699;4010.057636455431;4046.4941882264716;1187.7446349035;1275.0819410024767;1298.0913360647585;1308.672831792052;1309.4434865182259;1222.798238290672;1323.4904561743797;1327.681356474439;1362.3733082781832;1483.68842543065;7569.394448444111;7615.809604759926;7643.1974642662835;7650.923490765021;7733.961330193426;1016.2479764973866;1047.314009323894;1059.6344261229863;1087.4617064553097;1090.0571006079683;6131.816045518642;6140.570160088841;6230.7819226326865;6244.812655620339;6250.593711408744;9122.407043542282;9413.717588472357;9748.512574371252;9781.804363912683;9793.21654267657;9690.176335011462;9699.369540979813;9704.75738106553;9711.27165462593;9714.659986900424;7370.557766534025;7403.481756277117;7600.201978792147;7606.581638009852;7609.048868891388;7236.312550307713;7310.81722956909;7331.633418329169;7337.926620733938;7343.742968996059;8627.741167764978;8645.351598630003;8819.470831750115;8824.338174637056;8832.779180520281;8751.824963500567;8897.11028897131;8897.332700047651;8908.376413650982;8923.73228803137;7181.281871812986;7229.49393542447;7233.348998590152;7236.819079523054;7246.202917679157;6855.314468553105;6890;7740.032495938008;7808.453408261367;7808.570528620753;7185.497015208885;7189.856202876018;7192.892106618509;7326.084239470067;7402.1857595665515;7081.82295442618;7199.06412166415;7271.309225623558;7360.043194384696;7396.704131834666;7370.520916140434;7411.184769675439;7425.665845036879;7429.888551671621;7435.591042492499;6792.456603471612;6895.069165662571;6897.310268973263;6897.620630865351;6899.413549848118;6668.799936001928;6673.866522669617;6691.130153080068;6695.765648202289;6702.396784289437 00:58:10 INFO - 2015-12-16 00:58:10,560 DEBUG : BROWSER_OUTPUT: |4;prototype.html;362.1634025401322;364.4933542376097;364.66997367382527;365.90669379308287;366.8954348010816;5831.037878750001;5867.735951882165;5870.765169393225;5907.113932910066;5908.734106965191;5725.997950358691;5804.448577385152;5815.331236907757;5821.650700957945;5823.097419899912;4596.080783843245;4611.515790841963;4612.100640375128;4613.861584152481;4628.143793398215;4597.402337696095;4600.631949444037;4603.125406172833;4612.008418190088;4616.30755386693;4429.047754732732;4527.117212143633;4574.1080489304595;4592.47186573545;4600.631949444053;4556.407667003268;4596.563326483995;4597.816087356502;4600.1259760645535;4605.769711514411;3974.980125099356;4107.774072426016;4110.958890411088;4113.01287690952;4131.07050913545;5426.5116139547235;5521.66869987798;5643.040683083845;5651.350094739117;5659.462351076641;5338.492843179892;5347.893042139174;5366.865828354323;5373.838784836422;5376.193570964387;6223.159873417076;6262.812115636538;6277.403646653561;6280.2777680566405;6280.654563998978;4343.131373725268;4423.64610831136;4429.623482004002;4436.822527098912;4562.817487300504;6308.716107775161;6333.714982825784;6364.331745166784;6370.777022804226;6371.490280777527;4535.931961020588;4544.113897789899;4544.363789069533;4545.272756358967;4545.477270113913;4595.494495605481;4597.402337696078;4598.3792188054185;4601.585857272861;4601.884952876205;5204.0372531081875;5301.522862942354;5301.814436494704;5302.655327403706;5304.38999515053;6260.123582698426;6277.372262773686;6284.308726040132;6288.119663247149;6290.748370065146;1647.2258038721782;1665.9333626654798;1666.9914701605596;1667.7748503952055;1668.3743596151444;1130.7173206698326;1132.049078773834;1135.6309199510026;1150.8216226484908;1158.1198289300023;6048.818535443944;6054.697265136726;6064.9090263646085;6064.969675151596;6071.453569178795;6400.647964362005;6401.9039714404325;6407.903881441782;6408.455281301141;6419.839504012437;5942.584019118706;6046.727897244635;6050.30421501533;6055.122007308915;6059.4546490815155;3529.805860677687;3550.183457804719;3551.5915669698315;3557.2707594942976;3557.5375201223674;6373.808785736435;6449.193850768654;6464.062710906892;6573.704183311763;6580.86838263232;6498.447631951337;6561.901571476432;6578;6582.111414958919;6591.0442985766795;6492.123563318986;6495.8700825983215;6497.1878515186545;6500.577462465019;6569.047488114292;6186.597871138361;6394.1687580614225;6396.200474940632;6404.071409645669;6405.679716014088;6421.7110230038825;6428.292887782247;6429.421352078149;6436.356364363526;6437.163168788027;6641.568298060611;6643.1031810704935;6647.534672572873;6654.567453115532;6656.400923916871;4485.932711009403;4549.977250113729;4567.223571992703;4580.541945805393;4580.725156490621;6449.484041276781;6450.258220304725;6453.193350831146;6453.354664533509;6463.256725476443;6310.6844657766005;6327.209098862642;6327.3988971047675;6327.620342779263;6330.873382532415;6203.937960620336;6294.874102517832;6305.873882522415;6313.337099604659;6316.989281714904;6204.3795620437595;6209.416598767285;6213.316535181036;6213.565050446607;6214.627122372672;6306.243250809932;6335.271443784024;6347.68261586928;6350;6351.396617321347;6080.574359794772;6150.384961503813;6178.567500275118;6184.628922264678;6185.195924529962 00:58:10 INFO - 2015-12-16 00:58:10,561 DEBUG : BROWSER_OUTPUT: |5;yui.html;837.5853952293613;843.1231519220012;892.7277180459961;916.4776077635746;919.1635611593451;14583.781243281359;14911.850881491182;14914.105153690773;14931.253437328145;14940.402383904644;14453.060551064173;14521.782173267384;14563.708725825478;14573;14576.052556583814;775.5308038636629;789.6959670526832;913.4108500017485;922.8523436250201;948.5352177433043;927.1794461901233;929.1869614087673;945.7824700318931;946.0444950599875;946.7159852044393;817.3338728935928;989.6536212325665;989.7723523589578;991.8512223166547;992.2657233647121;819.2340161948567;963.1187463470951;992.7121134870879;995.0497275102332;995.5520015992832;711.8433944532195;717.3472140352306;718.138234119054;718.5473151914313;718.6514540447879;13645.863541364559;13818.516351927634;13841.653958651013;13847.723045539133;13851.445942162301;11134.888651113548;12744.426500807485;13043.804342934864;13109.147905386119;13187.07690461668;11178.329300242012;11179.385133817637;11522.827157592643;11529.769404611945;11644.126690498246;3906.921861562781;3921.0981474260793;3945.0729078666777;3963.4253033310297;4022.0950286185666;52616;52719;54364.72817635886;54541;54881.45118548843;11094.445277736242;11364.829527557093;11379.260348077349;11758.235714678518;11894.464749086312;20678.276260330815;20864.687029694567;20893.791062089487;20910.895445522674;20924.686129708065;8608.397412181212;8724.825503489894;8783.077776833341;8959.641614335484;9140.085991400807;4457;4527.750973696412;4541.591256786905;4590.380298659638;4628;3255.4953982132806;3281.5898012748407;3281.8851340202978;3286.7041966223155;3290.3254832759226;511.23059795008277;514.7760724085035;528.3131928492944;529.3013222546278;534.4068084426284;642.56947844944;652.517137318381;697.2121502702016;709.506892709562;724.380654540371;9023.909760902437;9108.134727200906;9221.677241296522;9305;9321.44071355721;545.3074595264072;549.4999550409188;583.8627922438224;619.7025427794683;747.5290566942791;4345.9348109778375;4354.368616550582;4459.732416055047;4494.202478802308;4495.100979804052;66663.33336666669;66914;66980;67058;67074.32925670681;59199.112013319835;59315.40684593185;60088.39911600828;60263.698681506314;60477.39522604806;51401;54364;54397.99999999921;54529;55358.16962745562;8966.417182883091;8994.325425592975;9040.683576074805;9087.909120908971;9129.132732390412;38118.23763524769;39009.414858776574;39691.80154099211;40813.795931020155;40851.182976340904;46750.298745519525;46765.76617116893;51131.48868511267;52890.47109529009;53139;7587.165411804807;7857.724979625686;7912.32745216663;7978.361731061617;8229.05365882931;12128;12192.146549741434;13134.2776147309;13414.32928353559;13588.524401645895;12417.31704756247;12545.49818007306;12779.1054626179;12902.096853220184;13164.868351316747;12340;12722.554710585086;12735.23588584688;12777.488900443877;13127.212367257995;11681.591144309908;11758.470868810753;12650.810237846625;13023.609291721263;13088.476460941836;10040.69877903664;10086.646967356108;10656.8934310659;10939.671809845717;11059.83410248863;10114.93793151738;10186.949065254626;10557.683269501927;10585.311954722918;10630.681079567625 00:58:10 INFO - 2015-12-16 00:58:10,561 DEBUG : BROWSER_OUTPUT: __end_tp_report 00:58:10 INFO - 2015-12-16 00:58:10,562 DEBUG : BROWSER_OUTPUT: __start_cc_report 00:58:10 INFO - 2015-12-16 00:58:10,562 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,834 00:58:10 INFO - 2015-12-16 00:58:10,562 DEBUG : BROWSER_OUTPUT: __end_cc_report 00:58:10 INFO - 2015-12-16 00:58:10,562 DEBUG : BROWSER_OUTPUT: __startTimestamp1450256290552__endTimestamp 00:58:10 INFO - 2015-12-16 00:58:10,562 DEBUG : BROWSER_OUTPUT: 00:58:10 INFO - 2015-12-16 00:58:10,562 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 00:58:10 INFO - 2015-12-16 00:58:10,562 DEBUG : BROWSER_OUTPUT: Number of tests: 6 00:58:10 INFO - 2015-12-16 00:58:10,562 DEBUG : BROWSER_OUTPUT: 00:58:10 INFO - 2015-12-16 00:58:10,562 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5618.93 Median:5849.74 stddev:622.47 (10.6%) stddev-sans-first:597.74 00:58:10 INFO - 2015-12-16 00:58:10,562 DEBUG : BROWSER_OUTPUT: Values: 3322.3 3372.6 3393.5 3403.1 3416.2 5616.4 5623.6 5633.4 5641.0 5642.8 5649.7 5653.0 5657.5 5667.9 5669.1 4950.2 5128.4 5138.8 5205.9 5229.6 5118.8 5121.4 5203.2 5223.8 5226.4 5178.7 5212.7 5219.7 5221.5 5240.9 4943.8 5142.8 5146.0 5219.7 5226.9 4980.6 4991.4 5112.0 5117.9 5144.4 5386.9 5459.6 5470.7 5484.2 5485.0 5914.8 6036.3 6115.7 6132.0 6134.5 5907.7 6018.2 6022.8 6026.4 6032.3 5644.4 5646.6 5648.1 5659.9 5751.2 6011.9 6070.5 6079.2 6096.7 6112.6 5985.3 5993.6 5993.8 5995.8 6009.4 6064.0 6069.5 6073.2 6080.1 6085.4 5968.0 6008.6 6037.5 6038.7 6142.4 6106.6 6109.3 6117.6 6119.1 6119.3 4657.5 4663.7 4665.2 4668.2 4684.9 3987.3 4067.0 4085.4 4185.8 4192.0 5789.8 5816.1 5822.8 5822.9 5823.6 5973.9 6156.3 6181.1 6184.5 6197.1 5568.3 5663.4 5683.0 5704.7 5731.3 5266.6 5298.9 5310.4 5314.3 5314.9 6013.2 6103.1 6269.9 6283.2 6287.6 5947.8 5949.7 5961.1 5989.0 5991.1 6236.4 6240.2 6241.4 6246.6 6246.8 5790.1 5892.9 5954.4 6007.2 6038.1 6060.4 6070.8 6076.5 6078.3 6089.1 5885.5 5888.4 5906.9 5913.7 5951.8 5744.8 5848.5 5889.6 5966.7 6007.8 5842.3 5846.9 5849.7 5852.4 5854.8 5882.0 5947.2 5950.0 5962.0 5963.2 5762.7 5767.9 5859.0 5871.9 5888.3 00:58:10 INFO - 2015-12-16 00:58:10,562 DEBUG : BROWSER_OUTPUT: 00:58:10 INFO - 2015-12-16 00:58:10,562 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:52106.73 Median:19551.89 stddev:90716.79 (464.0%) stddev-sans-first:90888.77 00:58:10 INFO - 2015-12-16 00:58:10,564 DEBUG : BROWSER_OUTPUT: Values: 578.1 615.7 624.9 653.5 656.3 35094.8 43021.4 43657.0 43881.1 43883.6 46887.8 47504.3 47509.3 47586.5 47593.5 7949.0 8062.7 9097.1 9284.0 10672.8 10949.3 11083.6 11093.2 11093.9 11097.2 10988.9 11049.6 11087.6 11105.7 11108.2 10931.2 11044.6 11050.5 11051.3 11057.2 10544.6 10728.3 10742.2 10785.7 10788.3 43330.4 43804.3 43839.0 43898.3 43907.1 3397.3 3538.8 3568.1 3663.9 3700.8 28881.7 28916.6 29223.4 29240.9 29878.3 3897.8 3983.6 3991.9 4011.9 4089.0 325432.0 325641.0 325803.0 325818.0 326798.0 58816.7 59985.7 64572.4 65032.0 69386.7 50925.7 51025.2 51088.0 51138.7 51209.5 17533.4 17799.6 17812.1 17814.8 17827.2 14637.6 14717.6 14743.7 14767.6 14820.5 20608.7 20942.5 20958.7 21017.5 21058.7 7620.6 7994.7 8014.6 8061.3 8102.6 915.7 941.0 983.9 1118.7 1121.4 30637.0 30829.7 31114.0 31452.8 31859.4 1103.8 1129.8 1135.7 1150.9 1174.5 14095.9 14701.0 14758.9 15186.2 16362.0 383660.0 388556.0 390969.0 393904.0 395305.0 51790.5 51861.7 56532.4 58452.0 59015.4 1318.7 1470.1 1472.4 1480.7 1516.2 24262.4 24393.6 24470.8 24627.1 24628.0 44706.6 45020.3 45129.0 45134.1 45150.8 316207.0 317926.0 318490.0 318907.0 319271.0 35249.5 35280.0 35752.6 35818.8 35924.3 46585.0 46813.3 47382.5 47682.8 47712.3 37939.0 38421.4 39572.2 39841.8 39909.6 40837.4 41629.4 42125.8 42225.4 43314.0 38685.0 39631.0 39668.4 39686.4 39753.6 34286.3 34561.7 35264.3 35832.8 35971.6 22849.8 23846.5 24314.5 35422.0 35535.6 00:58:10 INFO - 2015-12-16 00:58:10,564 DEBUG : BROWSER_OUTPUT: 00:58:10 INFO - 2015-12-16 00:58:10,564 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:29043.05 Median:26202.18 stddev:92715.14 (353.8%) stddev-sans-first:92950.27 00:58:10 INFO - 2015-12-16 00:58:10,564 DEBUG : BROWSER_OUTPUT: Values: 391.0 394.3 394.4 395.6 399.2 13102.2 14790.9 18837.8 20713.7 20720.2 19635.7 19635.8 19649.8 19655.6 19707.2 5963.8 6019.3 6075.0 6075.0 6094.7 5876.4 5985.1 6019.0 6030.7 6035.7 4426.7 4552.1 5972.8 5979.7 5983.1 6430.7 6523.7 6592.1 6618.0 6621.9 5762.9 5865.1 5897.9 5909.1 5909.6 14724.7 22638.7 22959.8 23173.0 23268.7 2104.6 2131.1 2190.5 2192.9 2196.3 10304.5 10396.7 10576.2 10593.8 10713.2 1784.3 1840.3 1843.0 1863.2 1881.9 66018.3 66896.0 66997.0 67300.0 67396.7 7891.5 7934.2 8015.4 8044.1 8080.0 9740.1 9740.2 9740.2 9742.8 9745.5 6392.7 6531.9 6560.1 6570.2 6582.5 6561.9 6583.9 6622.4 6743.2 6825.6 3687.9 3710.1 3715.5 3739.7 3755.0 1183.6 1224.8 1268.6 1304.3 1315.7 497.2 499.8 507.6 519.1 519.3 11364.8 13331.5 13482.9 13577.9 13894.3 529.8 533.5 537.9 541.5 556.0 5367.7 7155.6 7342.4 7366.2 7373.0 466018.0 477304.0 613571.0 621174.0 628796.0 73484.6 76053.0 76069.2 76374.6 77020.0 587.4 595.8 601.8 603.0 604.3 11865.2 11924.5 12009.3 12029.1 12037.3 35775.3 39269.8 39389.8 40840.2 41014.4 51896.7 52962.7 53661.2 53778.0 54035.0 7521.5 7640.6 7708.3 8019.4 8024.4 12864.6 13732.9 14229.1 14268.3 14338.4 11449.2 11500.5 11796.6 12199.3 12202.5 11744.9 11746.0 11794.4 11845.1 11863.9 9447.6 10090.8 10211.8 12174.0 12241.9 7614.2 7699.8 7717.3 7817.0 7852.1 11739.7 11837.0 12026.8 12182.7 12581.2 00:58:10 INFO - 2015-12-16 00:58:10,564 DEBUG : BROWSER_OUTPUT: 00:58:10 INFO - 2015-12-16 00:58:10,564 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5677.09 Median:6671.33 stddev:2871.72 (43.0%) stddev-sans-first:2861.64 00:58:10 INFO - 2015-12-16 00:58:10,566 DEBUG : BROWSER_OUTPUT: Values: 1384.2 1385.8 1456.4 1827.7 1847.3 7188.3 7355.0 8052.9 8239.2 8247.8 7645.8 7830.4 7901.4 7903.6 7909.7 2370.0 2406.3 2407.9 2408.2 2408.4 2109.0 2142.5 2326.1 2355.3 2374.8 2352.7 2360.9 2366.4 2367.3 2390.0 2395.5 2422.3 2426.9 2428.5 2428.6 2366.7 2420.0 2427.5 2431.3 2432.1 7908.1 7983.8 7996.5 7998.9 8001.2 4900.1 4929.4 4975.3 4976.3 4977.0 3302.8 3331.3 3339.7 3368.2 3374.7 1202.4 1212.9 1239.0 1254.8 1268.8 10689.1 10707.5 10715.7 10728.1 10740.7 4653.8 4687.0 4688.3 4721.7 4731.6 9542.2 9549.0 9560.2 9562.4 9567.6 4954.9 4960.9 4963.1 4963.9 4967.8 4466.5 4505.3 4505.8 4506.0 4509.1 3657.7 3980.0 4001.1 4010.1 4046.5 1187.7 1275.1 1298.1 1308.7 1309.4 1222.8 1323.5 1327.7 1362.4 1483.7 7569.4 7615.8 7643.2 7650.9 7734.0 1016.2 1047.3 1059.6 1087.5 1090.1 6131.8 6140.6 6230.8 6244.8 6250.6 9122.4 9413.7 9748.5 9781.8 9793.2 9690.2 9699.4 9704.8 9711.3 9714.7 7370.6 7403.5 7600.2 7606.6 7609.0 7236.3 7310.8 7331.6 7337.9 7343.7 8627.7 8645.4 8819.5 8824.3 8832.8 8751.8 8897.1 8897.3 8908.4 8923.7 7181.3 7229.5 7233.3 7236.8 7246.2 6855.3 6890.0 7740.0 7808.5 7808.6 7185.5 7189.9 7192.9 7326.1 7402.2 7081.8 7199.1 7271.3 7360.0 7396.7 7370.5 7411.2 7425.7 7429.9 7435.6 6792.5 6895.1 6897.3 6897.6 6899.4 6668.8 6673.9 6691.1 6695.8 6702.4 00:58:10 INFO - 2015-12-16 00:58:10,566 DEBUG : BROWSER_OUTPUT: 00:58:10 INFO - 2015-12-16 00:58:10,566 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5259.92 Median:5994.66 stddev:1536.10 (25.6%) stddev-sans-first:1495.77 00:58:10 INFO - 2015-12-16 00:58:10,567 DEBUG : BROWSER_OUTPUT: Values: 362.2 364.5 364.7 365.9 366.9 5831.0 5867.7 5870.8 5907.1 5908.7 5726.0 5804.4 5815.3 5821.7 5823.1 4596.1 4611.5 4612.1 4613.9 4628.1 4597.4 4600.6 4603.1 4612.0 4616.3 4429.0 4527.1 4574.1 4592.5 4600.6 4556.4 4596.6 4597.8 4600.1 4605.8 3975.0 4107.8 4111.0 4113.0 4131.1 5426.5 5521.7 5643.0 5651.4 5659.5 5338.5 5347.9 5366.9 5373.8 5376.2 6223.2 6262.8 6277.4 6280.3 6280.7 4343.1 4423.6 4429.6 4436.8 4562.8 6308.7 6333.7 6364.3 6370.8 6371.5 4535.9 4544.1 4544.4 4545.3 4545.5 4595.5 4597.4 4598.4 4601.6 4601.9 5204.0 5301.5 5301.8 5302.7 5304.4 6260.1 6277.4 6284.3 6288.1 6290.7 1647.2 1665.9 1667.0 1667.8 1668.4 1130.7 1132.0 1135.6 1150.8 1158.1 6048.8 6054.7 6064.9 6065.0 6071.5 6400.6 6401.9 6407.9 6408.5 6419.8 5942.6 6046.7 6050.3 6055.1 6059.5 3529.8 3550.2 3551.6 3557.3 3557.5 6373.8 6449.2 6464.1 6573.7 6580.9 6498.4 6561.9 6578.0 6582.1 6591.0 6492.1 6495.9 6497.2 6500.6 6569.0 6186.6 6394.2 6396.2 6404.1 6405.7 6421.7 6428.3 6429.4 6436.4 6437.2 6641.6 6643.1 6647.5 6654.6 6656.4 4485.9 4550.0 4567.2 4580.5 4580.7 6449.5 6450.3 6453.2 6453.4 6463.3 6310.7 6327.2 6327.4 6327.6 6330.9 6203.9 6294.9 6305.9 6313.3 6317.0 6204.4 6209.4 6213.3 6213.6 6214.6 6306.2 6335.3 6347.7 6350.0 6351.4 6080.6 6150.4 6178.6 6184.6 6185.2 00:58:10 INFO - 2015-12-16 00:58:10,568 DEBUG : BROWSER_OUTPUT: 00:58:10 INFO - 2015-12-16 00:58:10,569 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:15395.07 Median:46758.03 stddev:18442.07 (39.4%) stddev-sans-first:18461.40 00:58:10 INFO - 2015-12-16 00:58:10,570 DEBUG : BROWSER_OUTPUT: Values: 837.6 843.1 892.7 916.5 919.2 14583.8 14911.9 14914.1 14931.3 14940.4 14453.1 14521.8 14563.7 14573.0 14576.1 775.5 789.7 913.4 922.9 948.5 927.2 929.2 945.8 946.0 946.7 817.3 989.7 989.8 991.9 992.3 819.2 963.1 992.7 995.0 995.6 711.8 717.3 718.1 718.5 718.7 13645.9 13818.5 13841.7 13847.7 13851.4 11134.9 12744.4 13043.8 13109.1 13187.1 11178.3 11179.4 11522.8 11529.8 11644.1 3906.9 3921.1 3945.1 3963.4 4022.1 52616.0 52719.0 54364.7 54541.0 54881.5 11094.4 11364.8 11379.3 11758.2 11894.5 20678.3 20864.7 20893.8 20910.9 20924.7 8608.4 8724.8 8783.1 8959.6 9140.1 4457.0 4527.8 4541.6 4590.4 4628.0 3255.5 3281.6 3281.9 3286.7 3290.3 511.2 514.8 528.3 529.3 534.4 642.6 652.5 697.2 709.5 724.4 9023.9 9108.1 9221.7 9305.0 9321.4 545.3 549.5 583.9 619.7 747.5 4345.9 4354.4 4459.7 4494.2 4495.1 66663.3 66914.0 66980.0 67058.0 67074.3 59199.1 59315.4 60088.4 60263.7 60477.4 51401.0 54364.0 54398.0 54529.0 55358.2 8966.4 8994.3 9040.7 9087.9 9129.1 38118.2 39009.4 39691.8 40813.8 40851.2 46750.3 46765.8 51131.5 52890.5 53139.0 7587.2 7857.7 7912.3 7978.4 8229.1 12128.0 12192.1 13134.3 13414.3 13588.5 12417.3 12545.5 12779.1 12902.1 13164.9 12340.0 12722.6 12735.2 12777.5 13127.2 11681.6 11758.5 12650.8 13023.6 13088.5 10040.7 10086.6 10656.9 10939.7 11059.8 10114.9 10186.9 10557.7 10585.3 10630.7 00:58:10 INFO - 2015-12-16 00:58:10,570 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 00:58:10 INFO - 2015-12-16 00:58:10,570 DEBUG : BROWSER_OUTPUT: 00:58:11 INFO - 2015-12-16 00:58:11,173 INFO : Browser exited with error code: 0 00:58:11 INFO - 2015-12-16 00:58:11,189 INFO : Completed test dromaeo_css (00:18:30) 00:58:11 INFO - 2015-12-16 00:58:11,189 INFO : Starting test kraken 00:58:11 INFO - 2015-12-16 00:58:11,189 DEBUG : operating with platform_type : linux_ 00:58:11 INFO - 2015-12-16 00:58:11,189 INFO : Initialising browser for kraken test... 00:58:11 INFO - 2015-12-16 00:58:11,195 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpItK2n4/profile http://localhost:44667/getInfo.html 00:58:15 INFO - 2015-12-16 00:58:15,031 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 00:58:15 INFO - 2015-12-16 00:58:15,031 DEBUG : BROWSER_OUTPUT: colorDepth:24 00:58:15 INFO - 2015-12-16 00:58:15,031 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 00:58:15 INFO - 2015-12-16 00:58:15,031 DEBUG : BROWSER_OUTPUT: __metrics 00:58:15 INFO - 2015-12-16 00:58:15,127 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] 00:58:16 INFO - 2015-12-16 00:58:16,314 INFO : Browser initialized. 00:58:16 INFO - 2015-12-16 00:58:16,314 INFO : Running cycle 1/1 for kraken test... 00:58:16 INFO - 2015-12-16 00:58:16,315 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpItK2n4/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 00:58:27 INFO - 2015-12-16 00:58:27,959 DEBUG : BROWSER_OUTPUT: RSS: Main: 131088384 00:58:27 INFO - 2015-12-16 00:58:27,959 DEBUG : BROWSER_OUTPUT: 00:58:30 INFO - 2015-12-16 00:58:30,427 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44667/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44667/tests/kraken/driver.html?testName=audio-beat-detection) 00:58:31 INFO - 2015-12-16 00:58:31,009 DEBUG : BROWSER_OUTPUT: RSS: Main: 165298176 00:58:31 INFO - 2015-12-16 00:58:31,009 DEBUG : BROWSER_OUTPUT: 00:58:33 INFO - 2015-12-16 00:58:33,546 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44667/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44667/tests/kraken/driver.html?testName=audio-dft) 00:58:34 INFO - 2015-12-16 00:58:34,112 DEBUG : BROWSER_OUTPUT: RSS: Main: 161013760 00:58:34 INFO - 2015-12-16 00:58:34,112 DEBUG : BROWSER_OUTPUT: 00:58:36 INFO - 2015-12-16 00:58:36,878 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44667/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44667/tests/kraken/driver.html?testName=audio-fft) 00:58:37 INFO - 2015-12-16 00:58:37,439 DEBUG : BROWSER_OUTPUT: RSS: Main: 157339648 00:58:37 INFO - 2015-12-16 00:58:37,440 DEBUG : BROWSER_OUTPUT: 00:58:39 INFO - 2015-12-16 00:58:39,405 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44667/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44667/tests/kraken/driver.html?testName=audio-oscillator) 00:58:39 INFO - 2015-12-16 00:58:39,966 DEBUG : BROWSER_OUTPUT: RSS: Main: 157900800 00:58:39 INFO - 2015-12-16 00:58:39,966 DEBUG : BROWSER_OUTPUT: 00:58:42 INFO - 2015-12-16 00:58:42,090 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44667/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44667/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:58:42 INFO - 2015-12-16 00:58:42,645 DEBUG : BROWSER_OUTPUT: RSS: Main: 157294592 00:58:42 INFO - 2015-12-16 00:58:42,645 DEBUG : BROWSER_OUTPUT: 00:58:45 INFO - 2015-12-16 00:58:45,495 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44667/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44667/tests/kraken/driver.html?testName=imaging-darkroom) 00:58:46 INFO - 2015-12-16 00:58:46,062 DEBUG : BROWSER_OUTPUT: RSS: Main: 155361280 00:58:46 INFO - 2015-12-16 00:58:46,062 DEBUG : BROWSER_OUTPUT: 00:58:49 INFO - 2015-12-16 00:58:49,429 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44667/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44667/tests/kraken/driver.html?testName=imaging-desaturate) 00:58:49 INFO - 2015-12-16 00:58:49,995 DEBUG : BROWSER_OUTPUT: RSS: Main: 157790208 00:58:49 INFO - 2015-12-16 00:58:49,995 DEBUG : BROWSER_OUTPUT: 00:58:52 INFO - 2015-12-16 00:58:52,705 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44667/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44667/tests/kraken/driver.html?testName=json-parse-financial) 00:58:53 INFO - 2015-12-16 00:58:53,271 DEBUG : BROWSER_OUTPUT: RSS: Main: 154804224 00:58:53 INFO - 2015-12-16 00:58:53,271 DEBUG : BROWSER_OUTPUT: 00:58:54 INFO - 2015-12-16 00:58:54,780 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44667/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44667/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:58:55 INFO - 2015-12-16 00:58:55,341 DEBUG : BROWSER_OUTPUT: RSS: Main: 161570816 00:58:55 INFO - 2015-12-16 00:58:55,342 DEBUG : BROWSER_OUTPUT: 00:58:57 INFO - 2015-12-16 00:58:57,063 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44667/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44667/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:58:57 INFO - 2015-12-16 00:58:57,665 DEBUG : BROWSER_OUTPUT: RSS: Main: 161128448 00:58:57 INFO - 2015-12-16 00:58:57,665 DEBUG : BROWSER_OUTPUT: 00:58:59 INFO - 2015-12-16 00:58:59,598 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44667/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44667/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:59:00 INFO - 2015-12-16 00:59:00,159 DEBUG : BROWSER_OUTPUT: RSS: Main: 167292928 00:59:00 INFO - 2015-12-16 00:59:00,160 DEBUG : BROWSER_OUTPUT: 00:59:02 INFO - 2015-12-16 00:59:02,494 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44667/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44667/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:59:03 INFO - 2015-12-16 00:59:03,068 DEBUG : BROWSER_OUTPUT: RSS: Main: 171933696 00:59:03 INFO - 2015-12-16 00:59:03,068 DEBUG : BROWSER_OUTPUT: 00:59:05 INFO - 2015-12-16 00:59:05,487 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44667/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44667/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:59:06 INFO - 2015-12-16 00:59:06,053 DEBUG : BROWSER_OUTPUT: RSS: Main: 170348544 00:59:06 INFO - 2015-12-16 00:59:06,053 DEBUG : BROWSER_OUTPUT: 00:59:07 INFO - 2015-12-16 00:59:07,654 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44667/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44667/tests/kraken/driver.html?testName=ai-astar) 00:59:07 INFO - 2015-12-16 00:59:07,912 DEBUG : BROWSER_OUTPUT: RSS: Main: 229007360 00:59:07 INFO - 2015-12-16 00:59:07,912 DEBUG : BROWSER_OUTPUT: 00:59:07 INFO - 2015-12-16 00:59:07,912 DEBUG : BROWSER_OUTPUT: __start_tp_report 00:59:07 INFO - 2015-12-16 00:59:07,912 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 00:59:07 INFO - 2015-12-16 00:59:07,912 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 00:59:07 INFO - 2015-12-16 00:59:07,913 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 00:59:07 INFO - 2015-12-16 00:59:07,913 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;112;104;111;111;109;101;111;102;110 00:59:07 INFO - 2015-12-16 00:59:07,913 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;156;120;147;166;131;152;144;131;154;122 00:59:07 INFO - 2015-12-16 00:59:07,913 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;162;162;161;159;162;161;163;162;160 00:59:07 INFO - 2015-12-16 00:59:07,913 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;71;71;148;72;73;71;73;159;72 00:59:07 INFO - 2015-12-16 00:59:07,913 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;88;89;138;88;89;90;138;88;89;138 00:59:07 INFO - 2015-12-16 00:59:07,913 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;109;109;109;109;109;110;109 00:59:07 INFO - 2015-12-16 00:59:07,914 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;145;145;145;145;145;145;145;145;145 00:59:07 INFO - 2015-12-16 00:59:07,914 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;95;95;96;95;95;96;95;95 00:59:07 INFO - 2015-12-16 00:59:07,914 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;54;53;56;54;64;55;54;62;53;54 00:59:07 INFO - 2015-12-16 00:59:07,914 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;62;62;62;62;61;62;62;63;62;62 00:59:07 INFO - 2015-12-16 00:59:07,914 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;76;77;77;77;85;78;77;78;79;78 00:59:07 INFO - 2015-12-16 00:59:07,915 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;107;117;112;107;111;108;111;119;119;109 00:59:07 INFO - 2015-12-16 00:59:07,915 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;147;135;134;135;135;130;139;137;133;134 00:59:07 INFO - 2015-12-16 00:59:07,915 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;62;62;64;61;60;63;64;61;60;61 00:59:07 INFO - 2015-12-16 00:59:07,915 DEBUG : BROWSER_OUTPUT: __end_tp_report 00:59:07 INFO - 2015-12-16 00:59:07,915 DEBUG : BROWSER_OUTPUT: __start_cc_report 00:59:07 INFO - 2015-12-16 00:59:07,916 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,865 00:59:07 INFO - 2015-12-16 00:59:07,916 DEBUG : BROWSER_OUTPUT: __end_cc_report 00:59:07 INFO - 2015-12-16 00:59:07,916 DEBUG : BROWSER_OUTPUT: __startTimestamp1450256347906__endTimestamp 00:59:07 INFO - 2015-12-16 00:59:07,916 DEBUG : BROWSER_OUTPUT: 00:59:07 INFO - 2015-12-16 00:59:07,916 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 00:59:07 INFO - 2015-12-16 00:59:07,916 DEBUG : BROWSER_OUTPUT: Number of tests: 14 00:59:07 INFO - 2015-12-16 00:59:07,917 DEBUG : BROWSER_OUTPUT: 00:59:07 INFO - 2015-12-16 00:59:07,917 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.10 Median:110.50 stddev:4.12 (3.7%) stddev-sans-first:4.31 00:59:07 INFO - 2015-12-16 00:59:07,917 DEBUG : BROWSER_OUTPUT: Values: 110.0 112.0 104.0 111.0 111.0 109.0 101.0 111.0 102.0 110.0 00:59:07 INFO - 2015-12-16 00:59:07,917 DEBUG : BROWSER_OUTPUT: 00:59:07 INFO - 2015-12-16 00:59:07,917 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:142.30 Median:149.50 stddev:15.53 (10.4%) stddev-sans-first:15.66 00:59:07 INFO - 2015-12-16 00:59:07,917 DEBUG : BROWSER_OUTPUT: Values: 156.0 120.0 147.0 166.0 131.0 152.0 144.0 131.0 154.0 122.0 00:59:07 INFO - 2015-12-16 00:59:07,917 DEBUG : BROWSER_OUTPUT: 00:59:07 INFO - 2015-12-16 00:59:07,917 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.40 Median:162.00 stddev:1.17 (0.7%) stddev-sans-first:1.22 00:59:07 INFO - 2015-12-16 00:59:07,917 DEBUG : BROWSER_OUTPUT: Values: 162.0 162.0 162.0 161.0 159.0 162.0 161.0 163.0 162.0 160.0 00:59:07 INFO - 2015-12-16 00:59:07,917 DEBUG : BROWSER_OUTPUT: 00:59:07 INFO - 2015-12-16 00:59:07,918 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:88.20 Median:72.00 stddev:34.52 (47.9%) stddev-sans-first:36.11 00:59:07 INFO - 2015-12-16 00:59:07,918 DEBUG : BROWSER_OUTPUT: Values: 72.0 71.0 71.0 148.0 72.0 73.0 71.0 73.0 159.0 72.0 00:59:07 INFO - 2015-12-16 00:59:07,918 DEBUG : BROWSER_OUTPUT: 00:59:07 INFO - 2015-12-16 00:59:07,918 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:103.50 Median:88.50 stddev:23.82 (26.9%) stddev-sans-first:24.59 00:59:07 INFO - 2015-12-16 00:59:07,918 DEBUG : BROWSER_OUTPUT: Values: 88.0 89.0 138.0 88.0 89.0 90.0 138.0 88.0 89.0 138.0 00:59:07 INFO - 2015-12-16 00:59:07,918 DEBUG : BROWSER_OUTPUT: 00:59:07 INFO - 2015-12-16 00:59:07,918 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.10 Median:109.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 00:59:07 INFO - 2015-12-16 00:59:07,919 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 110.0 109.0 00:59:07 INFO - 2015-12-16 00:59:07,919 DEBUG : BROWSER_OUTPUT: 00:59:07 INFO - 2015-12-16 00:59:07,920 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.10 Median:145.00 stddev:0.32 (0.2%) stddev-sans-first:0.00 00:59:07 INFO - 2015-12-16 00:59:07,920 DEBUG : BROWSER_OUTPUT: Values: 146.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 00:59:07 INFO - 2015-12-16 00:59:07,920 DEBUG : BROWSER_OUTPUT: 00:59:07 INFO - 2015-12-16 00:59:07,920 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 00:59:07 INFO - 2015-12-16 00:59:07,920 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 95.0 95.0 96.0 95.0 95.0 96.0 95.0 95.0 00:59:07 INFO - 2015-12-16 00:59:07,920 DEBUG : BROWSER_OUTPUT: 00:59:07 INFO - 2015-12-16 00:59:07,920 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:55.90 Median:54.50 stddev:3.87 (7.1%) stddev-sans-first:4.04 00:59:07 INFO - 2015-12-16 00:59:07,920 DEBUG : BROWSER_OUTPUT: Values: 54.0 53.0 56.0 54.0 64.0 55.0 54.0 62.0 53.0 54.0 00:59:07 INFO - 2015-12-16 00:59:07,920 DEBUG : BROWSER_OUTPUT: 00:59:07 INFO - 2015-12-16 00:59:07,920 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:62.00 Median:62.00 stddev:0.47 (0.8%) stddev-sans-first:0.50 00:59:07 INFO - 2015-12-16 00:59:07,920 DEBUG : BROWSER_OUTPUT: Values: 62.0 62.0 62.0 62.0 61.0 62.0 62.0 63.0 62.0 62.0 00:59:07 INFO - 2015-12-16 00:59:07,920 DEBUG : BROWSER_OUTPUT: 00:59:07 INFO - 2015-12-16 00:59:07,920 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:78.20 Median:78.00 stddev:2.53 (3.2%) stddev-sans-first:2.55 00:59:07 INFO - 2015-12-16 00:59:07,920 DEBUG : BROWSER_OUTPUT: Values: 76.0 77.0 77.0 77.0 85.0 78.0 77.0 78.0 79.0 78.0 00:59:07 INFO - 2015-12-16 00:59:07,920 DEBUG : BROWSER_OUTPUT: 00:59:07 INFO - 2015-12-16 00:59:07,921 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:112.00 Median:111.50 stddev:4.71 (4.2%) stddev-sans-first:4.64 00:59:07 INFO - 2015-12-16 00:59:07,921 DEBUG : BROWSER_OUTPUT: Values: 107.0 117.0 112.0 107.0 111.0 108.0 111.0 119.0 119.0 109.0 00:59:07 INFO - 2015-12-16 00:59:07,921 DEBUG : BROWSER_OUTPUT: 00:59:07 INFO - 2015-12-16 00:59:07,921 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:135.90 Median:135.00 stddev:4.56 (3.4%) stddev-sans-first:2.50 00:59:07 INFO - 2015-12-16 00:59:07,921 DEBUG : BROWSER_OUTPUT: Values: 147.0 135.0 134.0 135.0 135.0 130.0 139.0 137.0 133.0 134.0 00:59:07 INFO - 2015-12-16 00:59:07,921 DEBUG : BROWSER_OUTPUT: 00:59:07 INFO - 2015-12-16 00:59:07,921 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.80 Median:62.00 stddev:1.48 (2.4%) stddev-sans-first:1.56 00:59:07 INFO - 2015-12-16 00:59:07,921 DEBUG : BROWSER_OUTPUT: Values: 62.0 62.0 64.0 61.0 60.0 63.0 64.0 61.0 60.0 61.0 00:59:07 INFO - 2015-12-16 00:59:07,921 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 00:59:07 INFO - 2015-12-16 00:59:07,921 DEBUG : BROWSER_OUTPUT: 00:59:08 INFO - 2015-12-16 00:59:08,625 INFO : Browser exited with error code: 0 00:59:08 INFO - 2015-12-16 00:59:08,676 INFO : Completed test kraken (00:00:57) 00:59:08 INFO - 2015-12-16 00:59:08,676 INFO : Starting test v8_7 00:59:08 INFO - 2015-12-16 00:59:08,676 DEBUG : operating with platform_type : linux_ 00:59:08 INFO - 2015-12-16 00:59:08,676 INFO : Initialising browser for v8_7 test... 00:59:08 INFO - 2015-12-16 00:59:08,682 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpv5AcKD/profile http://localhost:44667/getInfo.html 00:59:12 INFO - 2015-12-16 00:59:12,520 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 00:59:12 INFO - 2015-12-16 00:59:12,520 DEBUG : BROWSER_OUTPUT: colorDepth:24 00:59:12 INFO - 2015-12-16 00:59:12,520 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 00:59:12 INFO - 2015-12-16 00:59:12,520 DEBUG : BROWSER_OUTPUT: __metrics 00:59:12 INFO - 2015-12-16 00:59:12,588 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] 00:59:13 INFO - 2015-12-16 00:59:13,801 INFO : Browser initialized. 00:59:13 INFO - 2015-12-16 00:59:13,802 INFO : Running cycle 1/1 for v8_7 test... 00:59:13 INFO - 2015-12-16 00:59:13,802 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpv5AcKD/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 00:59:25 INFO - 2015-12-16 00:59:25,336 DEBUG : BROWSER_OUTPUT: RSS: Main: 131678208 00:59:25 INFO - 2015-12-16 00:59:25,336 DEBUG : BROWSER_OUTPUT: 00:59:46 INFO - 2015-12-16 00:59:46,738 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44667/tests/v8_7/run.html (next: http://localhost:44667/tests/v8_7/run.html) 00:59:46 INFO - 2015-12-16 00:59:46,988 DEBUG : BROWSER_OUTPUT: RSS: Main: 427184128 00:59:46 INFO - 2015-12-16 00:59:46,988 DEBUG : BROWSER_OUTPUT: 00:59:46 INFO - 2015-12-16 00:59:46,988 DEBUG : BROWSER_OUTPUT: __start_tp_report 00:59:46 INFO - 2015-12-16 00:59:46,990 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 00:59:46 INFO - 2015-12-16 00:59:46,990 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 00:59:46 INFO - 2015-12-16 00:59:46,990 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 00:59:46 INFO - 2015-12-16 00:59:46,990 DEBUG : BROWSER_OUTPUT: |0;Richards;163.6929120969062 00:59:46 INFO - 2015-12-16 00:59:46,990 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;170.1837985023826 00:59:46 INFO - 2015-12-16 00:59:46,990 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.42624789680315 00:59:46 INFO - 2015-12-16 00:59:46,991 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5005 00:59:46 INFO - 2015-12-16 00:59:46,991 DEBUG : BROWSER_OUTPUT: |4;RayTrace;945.179584120983 00:59:46 INFO - 2015-12-16 00:59:46,991 DEBUG : BROWSER_OUTPUT: |5;Earley;554.9389567147614 00:59:46 INFO - 2015-12-16 00:59:46,991 DEBUG : BROWSER_OUTPUT: |6;Boyer;10412.37113402062 00:59:46 INFO - 2015-12-16 00:59:46,991 DEBUG : BROWSER_OUTPUT: |7;RegExp;23720.93023255814 00:59:46 INFO - 2015-12-16 00:59:46,991 DEBUG : BROWSER_OUTPUT: |8;Splay;512.2950819672132 00:59:46 INFO - 2015-12-16 00:59:46,991 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4826.923076923077 00:59:46 INFO - 2015-12-16 00:59:46,991 DEBUG : BROWSER_OUTPUT: __end_tp_report 00:59:46 INFO - 2015-12-16 00:59:46,992 DEBUG : BROWSER_OUTPUT: __startTimestamp1450256386988__endTimestamp 00:59:46 INFO - 2015-12-16 00:59:46,992 DEBUG : BROWSER_OUTPUT: 00:59:46 INFO - 2015-12-16 00:59:46,992 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 00:59:46 INFO - 2015-12-16 00:59:46,992 DEBUG : BROWSER_OUTPUT: Number of tests: 10 00:59:46 INFO - 2015-12-16 00:59:46,992 DEBUG : BROWSER_OUTPUT: 00:59:46 INFO - 2015-12-16 00:59:46,992 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:163.69 Median:163.69 stddev:0.00 (0.0%) 00:59:46 INFO - 2015-12-16 00:59:46,992 DEBUG : BROWSER_OUTPUT: Values: 163.7 00:59:46 INFO - 2015-12-16 00:59:46,993 DEBUG : BROWSER_OUTPUT: 00:59:46 INFO - 2015-12-16 00:59:46,993 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:170.18 Median:170.18 stddev:0.00 (0.0%) 00:59:46 INFO - 2015-12-16 00:59:46,993 DEBUG : BROWSER_OUTPUT: Values: 170.2 00:59:46 INFO - 2015-12-16 00:59:46,993 DEBUG : BROWSER_OUTPUT: 00:59:46 INFO - 2015-12-16 00:59:46,993 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.43 Median:280.43 stddev:0.00 (0.0%) 00:59:46 INFO - 2015-12-16 00:59:46,993 DEBUG : BROWSER_OUTPUT: Values: 280.4 00:59:46 INFO - 2015-12-16 00:59:46,993 DEBUG : BROWSER_OUTPUT: 00:59:46 INFO - 2015-12-16 00:59:46,994 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5005.00 Median:5005.00 stddev:0.00 (0.0%) 00:59:46 INFO - 2015-12-16 00:59:46,994 DEBUG : BROWSER_OUTPUT: Values: 5005.0 00:59:46 INFO - 2015-12-16 00:59:46,994 DEBUG : BROWSER_OUTPUT: 00:59:46 INFO - 2015-12-16 00:59:46,994 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:945.18 Median:945.18 stddev:0.00 (0.0%) 00:59:46 INFO - 2015-12-16 00:59:46,994 DEBUG : BROWSER_OUTPUT: Values: 945.2 00:59:46 INFO - 2015-12-16 00:59:46,994 DEBUG : BROWSER_OUTPUT: 00:59:46 INFO - 2015-12-16 00:59:46,994 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:554.94 Median:554.94 stddev:0.00 (0.0%) 00:59:46 INFO - 2015-12-16 00:59:46,995 DEBUG : BROWSER_OUTPUT: Values: 554.9 00:59:46 INFO - 2015-12-16 00:59:46,995 DEBUG : BROWSER_OUTPUT: 00:59:46 INFO - 2015-12-16 00:59:46,995 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10412.37 Median:10412.37 stddev:0.00 (0.0%) 00:59:46 INFO - 2015-12-16 00:59:46,995 DEBUG : BROWSER_OUTPUT: Values: 10412.4 00:59:47 INFO - 2015-12-16 00:59:46,995 DEBUG : BROWSER_OUTPUT: 00:59:47 INFO - 2015-12-16 00:59:46,995 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:23720.93 Median:23720.93 stddev:0.00 (0.0%) 00:59:47 INFO - 2015-12-16 00:59:46,995 DEBUG : BROWSER_OUTPUT: Values: 23720.9 00:59:47 INFO - 2015-12-16 00:59:46,995 DEBUG : BROWSER_OUTPUT: 00:59:47 INFO - 2015-12-16 00:59:46,995 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:512.30 Median:512.30 stddev:0.00 (0.0%) 00:59:47 INFO - 2015-12-16 00:59:46,996 DEBUG : BROWSER_OUTPUT: Values: 512.3 00:59:47 INFO - 2015-12-16 00:59:46,996 DEBUG : BROWSER_OUTPUT: 00:59:47 INFO - 2015-12-16 00:59:46,996 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 00:59:47 INFO - 2015-12-16 00:59:46,996 DEBUG : BROWSER_OUTPUT: Values: 4826.9 00:59:47 INFO - 2015-12-16 00:59:46,996 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 00:59:47 INFO - 2015-12-16 00:59:46,996 DEBUG : BROWSER_OUTPUT: 00:59:47 INFO - 2015-12-16 00:59:47,665 INFO : Browser exited with error code: 0 00:59:47 INFO - 2015-12-16 00:59:47,677 INFO : Completed test v8_7 (00:00:39) 00:59:47 INFO - 2015-12-16 00:59:47,965 INFO : Completed test suite (00:20:06) 00:59:47 INFO - 2015-12-16 00:59:47,965 DEBUG : Working with test: dromaeo_css 00:59:47 INFO - 2015-12-16 00:59:47,965 DEBUG : Generating results file: dromaeo_css 00:59:47 INFO - 2015-12-16 00:59:47,966 DEBUG : Working with test: kraken 00:59:47 INFO - 2015-12-16 00:59:47,966 DEBUG : Generating results file: kraken 00:59:47 INFO - 2015-12-16 00:59:47,967 INFO : javascript benchmark 00:59:47 INFO - 2015-12-16 00:59:47,967 DEBUG : Working with test: v8_7 00:59:47 INFO - 2015-12-16 00:59:47,967 DEBUG : Generating results file: v8_7 00:59:47 INFO - 2015-12-16 00:59:47,967 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 00:59:48 INFO - 2015-12-16 00:59:48,021 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,53,35]] 00:59:48 INFO - 2015-12-16 00:59:48,021 DEBUG : process_Request line: dromaeo_css 7178.56 graph.html#tests=[[72,53,35]] 00:59:48 INFO - 2015-12-16 00:59:48,021 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 00:59:48 INFO - 2015-12-16 00:59:48,054 DEBUG : process_Request line: kraken 1458.80 graph.html#tests=[[232,53,35]] 00:59:48 INFO - 2015-12-16 00:59:48,055 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 00:59:48 INFO - 2015-12-16 00:59:48,086 DEBUG : process_Request line: v8_7 23418.63 graph.html#tests=[[230,53,35]] 00:59:48 INFO - 2015-12-16 00:59:48,088 INFO : javascript benchmark 00:59:48 INFO - 2015-12-16 00:59:48,091 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3322.3355328934213, 3372.6121496027963, 3393.457046872501, 3403.1322012886712, 3416.1630400551862, 5616.438356164382, 5623.550115990721, 5633.380328163898, 5640.9999999999945, 5642.774289028444, 5649.717514124298, 5653.0, 5657.462541058603, 5667.886642267152, 5669.149627555868, 4950.183219768734, 5128.410232823227, 5138.820141295056, 5205.86985325368, 5229.555487783543, 5118.820841270556, 5121.411037730652, 5203.19350500673, 5223.817166399177, 5226.372835259775, 5178.66338687986, 5212.687238765668, 5219.660722053073, 5221.451747566508, 5240.9213861792105, 4943.777530011158, 5142.7685754140775, 5146.0, 5219.73901304937, 5226.947730522684, 4980.601551875841, 4991.376077990251, 5111.974440127813, 5117.948820511784, 5144.382674079097, 5386.91919621206, 5459.563234941195, 5470.671759694431, 5484.232207490954, 5485.0, 5914.763409463616, 6036.305824830157, 6115.6942152892625, 6131.96934015327, 6134.478569321613, 5907.6750778707155, 6018.21763170785, 6022.789202377896, 6026.427489388501, 6032.336442991267, 5644.435556444323, 5646.632968857011, 5648.124540696199, 5659.886802263973, 5751.223584816038, 6011.909821352683, 6070.544709146831, 6079.209702738615, 6096.69516524172, 6112.633242005494, 5985.34161242263, 5993.640381577119, 5993.820185394445, 5995.760169593167, 6009.429104235091, 6063.969680151571, 6069.544784141207, 6073.18012068374, 6080.118382834465, 6085.421884920926, 5968.0, 6008.639481631116, 6037.45662890342, 6038.728257228435, 6142.416470435302, 6106.572539922163, 6109.266887973472, 6117.571769976148, 6119.082137679384, 6119.296280927661, 4657.464391594942, 4663.650226233046, 4665.183592871234, 4668.206404911105, 4684.906301873943, 3987.3420885554137, 4067.0, 4085.4076158956786, 4185.811638476276, 4192.014876504019, 5789.8263052108505, 5816.127580862904, 5822.7670893163795, 5822.912656310159, 5823.56323275756, 5973.910391344133, 6156.29202641693, 6181.134641150243, 6184.5052395808225, 6197.070439434031, 5568.3318001839225, 5663.405342438985, 5683.0, 5704.71476426177, 5731.340895797037, 5266.578673706094, 5298.947010529922, 5310.442403547572, 5314.335708036496, 5314.946850531523, 6013.188219590299, 6103.115048317969, 6269.905951410641, 6283.214598175228, 6287.591306565058, 5947.762089516371, 5949.702514874152, 5961.076033214858, 5989.0, 5991.101334799815, 6236.376362363727, 6240.188775459162, 6241.375862413723, 6246.562740608114, 6246.750129994749, 5790.10253410722, 5892.911606325994, 5954.404559544011, 6007.158997740407, 6038.094285857156, 6060.363661815446, 6070.848228794139, 6076.453119219114, 6078.270607527125, 6089.056196289582, 5885.47030767233, 5888.352281249145, 5906.911396328973, 5913.674747888907, 5951.791687290924, 5744.770209191585, 5848.473637372657, 5889.617174883619, 5966.731497082555, 6007.8197654070445, 5842.269716285465, 5846.853828654318, 5849.736761845642, 5852.356240813592, 5854.824355269178, 5881.970590147193, 5947.226860508279, 5950.0, 5962.046072628359, 5963.224780778471, 5762.6830524319885, 5767.942320576741, 5859.0, 5871.853203669943, 5888.3228428731245], "unit": "ms", "name": "dojo.html", "value": 5578.417344611037}, {"lowerIsBetter": false, "replicates": [578.1443463673763, 615.664462867737, 624.8719012602415, 653.5457856789527, 656.3305428462965, 35094.8245258774, 43021.35467967979, 43657.0, 43881.12237755243, 43883.561164388346, 46887.76556117215, 47504.28743568849, 47509.28736068962, 47586.52413475864, 47593.524064759345, 7949.0, 8062.71780487683, 9097.13577210164, 9284.0, 10672.839907401396, 10949.288296260758, 11083.556657733681, 11093.168012399063, 11093.944530277337, 11097.16771242156, 10988.890111098906, 11049.613263535777, 11087.55649774008, 11105.666829995072, 11108.16688748343, 10931.234813563055, 11044.613438529654, 11050.502727377287, 11051.281666691679, 11057.170712196537, 10544.578216871316, 10728.302660327132, 10742.194335424796, 10785.730356741065, 10788.298760580537, 43330.35004474936, 43804.342934856, 43839.0, 43898.34152487715, 43907.12185756267, 3397.269587038774, 3538.752287339887, 3568.1436455250814, 3663.8900832975055, 3700.833462494194, 28881.711182888113, 28916.566251506243, 29223.39348163387, 29240.853795730884, 29878.25304367408, 3897.7856217908, 3983.5817239190046, 3991.900202494932, 4011.8997025074314, 4089.0390758171807, 325432.0, 325641.0, 325803.0, 325818.0, 326798.0, 58816.705916471, 59985.70007149936, 64572.354276457576, 65032.0, 69386.65306673535, 50925.745371272904, 51025.234621480704, 51088.0, 51138.74430627823, 51209.48790512047, 17533.386331478338, 17799.644007119787, 17812.10939453022, 17814.821851781577, 17827.197776100107, 14637.560873173821, 14717.55847324582, 14743.705125897422, 14767.556973290819, 14820.481283155254, 20608.690869636666, 20942.47643808917, 20958.685619715718, 21017.474563136046, 21058.684119738216, 7620.5808680523105, 7994.680212791423, 8014.559199243981, 8061.2744852963515, 8102.594870256464, 915.7481692534473, 940.971770846862, 983.8671779309844, 1118.7426891814928, 1121.3664279681955, 30637.0, 30829.691703083132, 31114.0, 31452.842735786173, 31859.36281274408, 1103.8289065194908, 1129.7909886670993, 1135.6888731431497, 1150.9123877935272, 1174.453878946294, 14095.859041409454, 14701.0, 14758.852411475962, 15186.164760938254, 16362.018278903304, 383660.0, 388556.0, 390969.0, 393904.0, 395305.0, 51790.482095178566, 51861.740691297055, 56532.434675652716, 58452.0, 59015.40984590185, 1318.7098838255567, 1470.147314557554, 1472.3595236072129, 1480.7334679757746, 1516.2494565190082, 24262.393440164138, 24393.634095488225, 24470.755292446847, 24627.13805016816, 24628.0, 44706.55293447024, 45020.32469513026, 45129.0, 45134.09731805411, 45150.77424612856, 316207.0, 317926.0, 318490.0, 318907.0, 319271.0, 35249.471257930636, 35280.0, 35752.64247357493, 35818.82090589635, 35924.28151437009, 46585.0, 46813.29780053234, 47382.52617473781, 47682.761586191846, 47712.28431573599, 37939.0, 38421.4236786454, 39572.20855582815, 39841.80079099586, 39909.60090399175, 40837.38743918903, 41629.37555936724, 42125.789371052946, 42225.36661950012, 43314.0, 38685.0, 39631.0, 39668.40497392484, 39686.404703928885, 39753.60246397499, 34286.314273713884, 34561.65438345685, 35264.29471410506, 35832.820835895654, 35971.640283596826, 22849.771502284766, 23846.52306953886, 24314.513709725354, 35422.0, 35535.64464355427], "unit": "ms", "name": "ext.html", "value": 20147.088577314113}, {"lowerIsBetter": false, "replicates": [390.9824057917393, 394.34341820868246, 394.3552292002575, 395.55895176877755, 399.20956506117886, 13102.213867167953, 14790.852091479082, 18837.81162188378, 20713.68929466059, 20720.171193152255, 19635.705464418046, 19635.803641963576, 19649.803501964976, 19655.606887862235, 19707.211711531523, 5963.791267305634, 6019.337872833985, 6075.0, 6075.0, 6094.664793436359, 5876.382979787125, 5985.072313791369, 6018.969905150469, 6030.728617212236, 6035.728392222339, 4426.712263702865, 4552.08958208358, 5972.820815375546, 5979.730912108944, 5983.072623743326, 6430.742770289183, 6523.739050437976, 6592.077109204715, 6617.966910165443, 6621.867562648744, 5762.942370576325, 5865.149553314788, 5897.941020589782, 5909.113632955048, 5909.556783241274, 14724.705505889822, 22638.66042009371, 22959.77040229593, 23173.0, 23268.65097023546, 2104.600125976075, 2131.0516820014946, 2190.452386903274, 2192.8793916334594, 2196.2642514757417, 10304.536295866628, 10396.688099357032, 10576.206784491194, 10593.84109238362, 10713.196510261683, 1784.286285485803, 1840.3282801777389, 1843.0, 1863.170888954416, 1881.868269221155, 66018.3398166017, 66896.0, 66997.0, 67300.0, 67396.6630166851, 7891.526508409514, 7934.20657934202, 8015.398845086642, 8044.074931382849, 8080.030396352476, 9740.074692904163, 9740.17208537268, 9740.172085372822, 9742.75643108928, 9745.512724363753, 6392.680365981682, 6531.8693626127215, 6560.114384558119, 6570.211574611078, 6582.506312026521, 6561.901571476432, 6583.868322633521, 6622.37087476689, 6743.15710536183, 6825.55633883796, 3687.9262414751556, 3710.0539362462937, 3715.461258117558, 3739.719521035933, 3754.962450375516, 1183.556166437586, 1224.8040313549789, 1268.5750273658243, 1304.2565737529708, 1315.7105436803888, 497.19950879084644, 499.7626127589366, 507.6192855358481, 519.125273913457, 519.3404376441898, 11364.772704546029, 13331.533396331082, 13482.932585337207, 13577.864221357857, 13894.305284735925, 529.7960285290114, 533.5038414274684, 537.8870437208152, 541.4882935625875, 555.9908765590441, 5367.704776237344, 7155.642217889084, 7342.4493163012985, 7366.226546212678, 7372.96313518429, 466018.0, 477304.0, 613571.0, 621174.0, 628796.0, 73484.63257683677, 76053.0, 76069.23930760621, 76374.61812690902, 77020.0, 587.4096532984323, 595.7637901354619, 601.8044135655929, 603.0200923499314, 604.2778879239355, 11865.228760130563, 11924.523019079139, 12009.279443233434, 12029.097817663886, 12037.277763333877, 35775.284494309446, 39269.803650981565, 39389.80305098456, 40840.183196336504, 41014.38478422767, 51896.74051629718, 52962.73853397922, 53661.19508207302, 53778.0, 54035.0, 7521.548707077593, 7640.617969101634, 7708.344790692854, 8019.358451323997, 8024.398170137147, 12864.614061578168, 13732.862671373558, 14229.075110117808, 14268.286585670883, 14338.354774034984, 11449.198556101326, 11500.53997840077, 11796.646100616996, 12199.329036903055, 12202.450889709808, 11744.94127529357, 11746.0, 11794.351310677996, 11845.11161662896, 11863.940680296544, 9447.574859131493, 10090.798184036425, 10211.84682229782, 12174.026077913568, 12241.938790305992, 7614.16244213125, 7699.769006929801, 7717.344025757873, 7816.960915195615, 7852.136265010959, 11739.706507337385, 11837.0, 12026.75946481083, 12182.695432614255, 12581.245125292511], "unit": "ms", "name": "jquery.html", "value": 7932.500211281966}, {"lowerIsBetter": false, "replicates": [1384.1556650443229, 1385.8198434203553, 1456.4028748213234, 1827.734978428127, 1847.270328220353, 7188.317109874553, 7354.963225183867, 8052.919470805297, 8239.176082391758, 8247.793805154866, 7645.770626881203, 7830.373570114377, 7901.407394445411, 7903.604819759018, 7909.683612655487, 2369.9763002370014, 2406.254061241012, 2407.9157229496973, 2408.1812183857487, 2408.385861605297, 2108.9789102108934, 2142.464383904024, 2326.09282379872, 2355.3287313115766, 2374.8218883583713, 2352.6706261123454, 2360.905563777447, 2366.3610825077303, 2367.337145599235, 2390.032037025008, 2395.4849707312924, 2422.2854257993936, 2426.9271921842374, 2428.538577670237, 2428.647846062329, 2366.6568347589673, 2420.0, 2427.538767634144, 2431.258466167818, 2432.1487479382254, 7908.130105688369, 7983.8403231935035, 7996.480228785169, 7998.920010799934, 8001.19988001201, 4900.068986892479, 4929.408470983505, 4975.253711943237, 4976.253561965698, 4976.975115124437, 3302.78531895426, 3331.25046864456, 3339.699427051553, 3368.225308179108, 3374.746893982961, 1202.4468744377598, 1212.8847759462926, 1238.9876101238963, 1254.7866862633375, 1268.758935802204, 10689.091427228695, 10707.518161682743, 10715.732106697316, 10728.141748660088, 10740.677779666623, 4653.790579423934, 4687.039156972813, 4688.343631891538, 4721.6694831362165, 4731.597814185764, 9542.236621070298, 9549.0, 9560.187384072293, 9562.378445401027, 9567.61729530825, 4954.900901982012, 4960.875978100504, 4963.081829861487, 4963.851084467472, 4967.776450059684, 4466.4640243171025, 4505.256632655575, 4505.797239124247, 4505.977470112629, 4509.120721459284, 3657.7073834093208, 3980.0, 4001.139754952699, 4010.057636455431, 4046.4941882264716, 1187.7446349035, 1275.0819410024767, 1298.0913360647585, 1308.672831792052, 1309.4434865182259, 1222.798238290672, 1323.4904561743797, 1327.681356474439, 1362.3733082781832, 1483.68842543065, 7569.394448444111, 7615.809604759926, 7643.1974642662835, 7650.923490765021, 7733.961330193426, 1016.2479764973866, 1047.314009323894, 1059.6344261229863, 1087.4617064553097, 1090.0571006079683, 6131.816045518642, 6140.570160088841, 6230.7819226326865, 6244.812655620339, 6250.593711408744, 9122.407043542282, 9413.717588472357, 9748.512574371252, 9781.804363912683, 9793.21654267657, 9690.176335011462, 9699.369540979813, 9704.75738106553, 9711.27165462593, 9714.659986900424, 7370.557766534025, 7403.481756277117, 7600.201978792147, 7606.581638009852, 7609.048868891388, 7236.312550307713, 7310.81722956909, 7331.633418329169, 7337.926620733938, 7343.742968996059, 8627.741167764978, 8645.351598630003, 8819.470831750115, 8824.338174637056, 8832.779180520281, 8751.824963500567, 8897.11028897131, 8897.332700047651, 8908.376413650982, 8923.73228803137, 7181.281871812986, 7229.49393542447, 7233.348998590152, 7236.819079523054, 7246.202917679157, 6855.314468553105, 6890.0, 7740.032495938008, 7808.453408261367, 7808.570528620753, 7185.497015208885, 7189.856202876018, 7192.892106618509, 7326.084239470067, 7402.1857595665515, 7081.82295442618, 7199.06412166415, 7271.309225623558, 7360.043194384696, 7396.704131834666, 7370.520916140434, 7411.184769675439, 7425.665845036879, 7429.888551671621, 7435.591042492499, 6792.456603471612, 6895.069165662571, 6897.310268973263, 6897.620630865351, 6899.413549848118, 6668.799936001928, 6673.866522669617, 6691.130153080068, 6695.765648202289, 6702.396784289437], "unit": "ms", "name": "mootools.html", "value": 4707.07405896703}, {"lowerIsBetter": false, "replicates": [362.1634025401322, 364.4933542376097, 364.66997367382527, 365.90669379308287, 366.8954348010816, 5831.037878750001, 5867.735951882165, 5870.765169393225, 5907.113932910066, 5908.734106965191, 5725.997950358691, 5804.448577385152, 5815.331236907757, 5821.650700957945, 5823.097419899912, 4596.080783843245, 4611.515790841963, 4612.100640375128, 4613.861584152481, 4628.143793398215, 4597.402337696095, 4600.631949444037, 4603.125406172833, 4612.008418190088, 4616.30755386693, 4429.047754732732, 4527.117212143633, 4574.1080489304595, 4592.47186573545, 4600.631949444053, 4556.407667003268, 4596.563326483995, 4597.816087356502, 4600.1259760645535, 4605.769711514411, 3974.980125099356, 4107.774072426016, 4110.958890411088, 4113.01287690952, 4131.07050913545, 5426.5116139547235, 5521.66869987798, 5643.040683083845, 5651.350094739117, 5659.462351076641, 5338.492843179892, 5347.893042139174, 5366.865828354323, 5373.838784836422, 5376.193570964387, 6223.159873417076, 6262.812115636538, 6277.403646653561, 6280.2777680566405, 6280.654563998978, 4343.131373725268, 4423.64610831136, 4429.623482004002, 4436.822527098912, 4562.817487300504, 6308.716107775161, 6333.714982825784, 6364.331745166784, 6370.777022804226, 6371.490280777527, 4535.931961020588, 4544.113897789899, 4544.363789069533, 4545.272756358967, 4545.477270113913, 4595.494495605481, 4597.402337696078, 4598.3792188054185, 4601.585857272861, 4601.884952876205, 5204.0372531081875, 5301.522862942354, 5301.814436494704, 5302.655327403706, 5304.38999515053, 6260.123582698426, 6277.372262773686, 6284.308726040132, 6288.119663247149, 6290.748370065146, 1647.2258038721782, 1665.9333626654798, 1666.9914701605596, 1667.7748503952055, 1668.3743596151444, 1130.7173206698326, 1132.049078773834, 1135.6309199510026, 1150.8216226484908, 1158.1198289300023, 6048.818535443944, 6054.697265136726, 6064.9090263646085, 6064.969675151596, 6071.453569178795, 6400.647964362005, 6401.9039714404325, 6407.903881441782, 6408.455281301141, 6419.839504012437, 5942.584019118706, 6046.727897244635, 6050.30421501533, 6055.122007308915, 6059.4546490815155, 3529.805860677687, 3550.183457804719, 3551.5915669698315, 3557.2707594942976, 3557.5375201223674, 6373.808785736435, 6449.193850768654, 6464.062710906892, 6573.704183311763, 6580.86838263232, 6498.447631951337, 6561.901571476432, 6578.0, 6582.111414958919, 6591.0442985766795, 6492.123563318986, 6495.8700825983215, 6497.1878515186545, 6500.577462465019, 6569.047488114292, 6186.597871138361, 6394.1687580614225, 6396.200474940632, 6404.071409645669, 6405.679716014088, 6421.7110230038825, 6428.292887782247, 6429.421352078149, 6436.356364363526, 6437.163168788027, 6641.568298060611, 6643.1031810704935, 6647.534672572873, 6654.567453115532, 6656.400923916871, 4485.932711009403, 4549.977250113729, 4567.223571992703, 4580.541945805393, 4580.725156490621, 6449.484041276781, 6450.258220304725, 6453.193350831146, 6453.354664533509, 6463.256725476443, 6310.6844657766005, 6327.209098862642, 6327.3988971047675, 6327.620342779263, 6330.873382532415, 6203.937960620336, 6294.874102517832, 6305.873882522415, 6313.337099604659, 6316.989281714904, 6204.3795620437595, 6209.416598767285, 6213.316535181036, 6213.565050446607, 6214.627122372672, 6306.243250809932, 6335.271443784024, 6347.68261586928, 6350.0, 6351.396617321347, 6080.574359794772, 6150.384961503813, 6178.567500275118, 6184.628922264678, 6185.195924529962], "unit": "ms", "name": "prototype.html", "value": 4775.550682344569}, {"lowerIsBetter": false, "replicates": [837.5853952293613, 843.1231519220012, 892.7277180459961, 916.4776077635746, 919.1635611593451, 14583.781243281359, 14911.850881491182, 14914.105153690773, 14931.253437328145, 14940.402383904644, 14453.060551064173, 14521.782173267384, 14563.708725825478, 14573.0, 14576.052556583814, 775.5308038636629, 789.6959670526832, 913.4108500017485, 922.8523436250201, 948.5352177433043, 927.1794461901233, 929.1869614087673, 945.7824700318931, 946.0444950599875, 946.7159852044393, 817.3338728935928, 989.6536212325665, 989.7723523589578, 991.8512223166547, 992.2657233647121, 819.2340161948567, 963.1187463470951, 992.7121134870879, 995.0497275102332, 995.5520015992832, 711.8433944532195, 717.3472140352306, 718.138234119054, 718.5473151914313, 718.6514540447879, 13645.863541364559, 13818.516351927634, 13841.653958651013, 13847.723045539133, 13851.445942162301, 11134.888651113548, 12744.426500807485, 13043.804342934864, 13109.147905386119, 13187.07690461668, 11178.329300242012, 11179.385133817637, 11522.827157592643, 11529.769404611945, 11644.126690498246, 3906.921861562781, 3921.0981474260793, 3945.0729078666777, 3963.4253033310297, 4022.0950286185666, 52616.0, 52719.0, 54364.72817635886, 54541.0, 54881.45118548843, 11094.445277736242, 11364.829527557093, 11379.260348077349, 11758.235714678518, 11894.464749086312, 20678.276260330815, 20864.687029694567, 20893.791062089487, 20910.895445522674, 20924.686129708065, 8608.397412181212, 8724.825503489894, 8783.077776833341, 8959.641614335484, 9140.085991400807, 4457.0, 4527.750973696412, 4541.591256786905, 4590.380298659638, 4628.0, 3255.4953982132806, 3281.5898012748407, 3281.8851340202978, 3286.7041966223155, 3290.3254832759226, 511.23059795008277, 514.7760724085035, 528.3131928492944, 529.3013222546278, 534.4068084426284, 642.56947844944, 652.517137318381, 697.2121502702016, 709.506892709562, 724.380654540371, 9023.909760902437, 9108.134727200906, 9221.677241296522, 9305.0, 9321.44071355721, 545.3074595264072, 549.4999550409188, 583.8627922438224, 619.7025427794683, 747.5290566942791, 4345.9348109778375, 4354.368616550582, 4459.732416055047, 4494.202478802308, 4495.100979804052, 66663.33336666669, 66914.0, 66980.0, 67058.0, 67074.32925670681, 59199.112013319835, 59315.40684593185, 60088.39911600828, 60263.698681506314, 60477.39522604806, 51401.0, 54364.0, 54397.99999999921, 54529.0, 55358.16962745562, 8966.417182883091, 8994.325425592975, 9040.683576074805, 9087.909120908971, 9129.132732390412, 38118.23763524769, 39009.414858776574, 39691.80154099211, 40813.795931020155, 40851.182976340904, 46750.298745519525, 46765.76617116893, 51131.48868511267, 52890.47109529009, 53139.0, 7587.165411804807, 7857.724979625686, 7912.32745216663, 7978.361731061617, 8229.05365882931, 12128.0, 12192.146549741434, 13134.2776147309, 13414.32928353559, 13588.524401645895, 12417.31704756247, 12545.49818007306, 12779.1054626179, 12902.096853220184, 13164.868351316747, 12340.0, 12722.554710585086, 12735.23588584688, 12777.488900443877, 13127.212367257995, 11681.591144309908, 11758.470868810753, 12650.810237846625, 13023.609291721263, 13088.476460941836, 10040.69877903664, 10086.646967356108, 10656.8934310659, 10939.671809845717, 11059.83410248863, 10114.93793151738, 10186.949065254626, 10557.683269501927, 10585.311954722918, 10630.681079567625], "unit": "ms", "name": "yui.html", "value": 6827.76709896754}], "name": "dromaeo_css", "value": 7178.561484052611}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 112.0, 104.0, 111.0, 111.0, 109.0, 101.0, 111.0, 102.0, 110.0], "unit": "ms", "name": "ai-astar", "value": 108.1}, {"lowerIsBetter": true, "replicates": [156.0, 120.0, 147.0, 166.0, 131.0, 152.0, 144.0, 131.0, 154.0, 122.0], "unit": "ms", "name": "audio-beat-detection", "value": 142.3}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 162.0, 161.0, 159.0, 162.0, 161.0, 163.0, 162.0, 160.0], "unit": "ms", "name": "audio-dft", "value": 161.4}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 71.0, 148.0, 72.0, 73.0, 71.0, 73.0, 159.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 88.2}, {"lowerIsBetter": true, "replicates": [88.0, 89.0, 138.0, 88.0, 89.0, 90.0, 138.0, 88.0, 89.0, 138.0], "unit": "ms", "name": "audio-oscillator", "value": 103.5}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.1}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.1}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.3}, {"lowerIsBetter": true, "replicates": [54.0, 53.0, 56.0, 54.0, 64.0, 55.0, 54.0, 62.0, 53.0, 54.0], "unit": "ms", "name": "json-parse-financial", "value": 55.9}, {"lowerIsBetter": true, "replicates": [62.0, 62.0, 62.0, 62.0, 61.0, 62.0, 62.0, 63.0, 62.0, 62.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 62.0}, {"lowerIsBetter": true, "replicates": [76.0, 77.0, 77.0, 77.0, 85.0, 78.0, 77.0, 78.0, 79.0, 78.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 78.2}, {"lowerIsBetter": true, "replicates": [107.0, 117.0, 112.0, 107.0, 111.0, 108.0, 111.0, 119.0, 119.0, 109.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 112.0}, {"lowerIsBetter": true, "replicates": [147.0, 135.0, 134.0, 135.0, 135.0, 130.0, 139.0, 137.0, 133.0, 134.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 135.9}, {"lowerIsBetter": true, "replicates": [62.0, 62.0, 64.0, 61.0, 60.0, 63.0, 64.0, 61.0, 60.0, 61.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 61.8}], "name": "kraken", "value": 1458.8000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [163.6929120969062], "unit": "score", "name": "Richards", "value": 215.65991799999992}, {"lowerIsBetter": false, "replicates": [170.1837985023826], "unit": "score", "name": "DeltaBlue", "value": 388.5093679999998}, {"lowerIsBetter": false, "replicates": [280.42624789680315], "unit": "score", "name": "Encrypt", "value": 949.2014460000001}, {"lowerIsBetter": false, "replicates": [5005.0], "unit": "score", "name": "Decrypt", "value": 53.18301698301701}, {"lowerIsBetter": false, "replicates": [945.179584120983], "unit": "score", "name": "RayTrace", "value": 782.908362}, {"lowerIsBetter": false, "replicates": [554.9389567147614], "unit": "score", "name": "Earley", "value": 1200.966326}, {"lowerIsBetter": false, "replicates": [10412.37113402062], "unit": "score", "name": "Boyer", "value": 64.00684257425743}, {"lowerIsBetter": false, "replicates": [23720.93023255814], "unit": "score", "name": "RegExp", "value": 38.40426960784315}, {"lowerIsBetter": false, "replicates": [512.2950819672132], "unit": "score", "name": "Splay", "value": 159.07043199999998}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 23418.630324151873}]} 00:59:48 INFO - RETURN: dromaeo_css: 7178.56 00:59:48 INFO - RETURN: kraken: 1458.80 00:59:48 INFO - RETURN: v8_7: 23418.63 00:59:48 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,53,35]]", "result": "23418.63"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,53,35]]", "result": "1458.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,53,35]]", "result": "7178.56"}}} 00:59:48 INFO - Return code: 0 00:59:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 00:59:48 INFO - # TBPL SUCCESS # 00:59:48 INFO - Running post-action listener: _resource_record_post_action 00:59:48 INFO - Running post-run listener: _resource_record_post_run 00:59:49 INFO - Total resource usage - Wall time: 1222s; CPU: 13.0%; Read bytes: 4096; Write bytes: 358014976; Read time: 12; Write time: 190288 00:59:49 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 97116160; Read time: 0; Write time: 47224 00:59:49 INFO - run-tests - Wall time: 1208s; CPU: 13.0%; Read bytes: 4096; Write bytes: 260898816; Read time: 12; Write time: 143064 00:59:49 INFO - Running post-run listener: _upload_blobber_files 00:59:49 INFO - Blob upload gear active. 00:59:49 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 00:59:49 INFO - Copying logs to upload dir... 00:59:49 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1270.228577 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2015-12-16 00:59:48.933927) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-16 00:59:48.937549) ========= 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=e10134013339c31d8d0c4708000001d6-1450233150.717384-950284369 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450246929/firefox-44.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010134 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450246929/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-16 00:59:48.989131) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 00:59:48.989485) ========= 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=e10134013339c31d8d0c4708000001d6-1450233150.717384-950284369 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004495 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 00:59:49.040186) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-16 00:59:49.040519) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-16 00:59:49.040851) ========= ========= Total master_lag: 0.22 =========