builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-067 starttime: 1451336789.04 results: success (0) buildid: 20151228105330 builduid: 6d65666499d14a4a941a7590d4129318 revision: 4413def26994 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-28 13:06:29.036746) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-28 13:06:29.037223) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-28 13:06:29.037736) ========= 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=3e14eba40af1795cf0357910000001c3-1451332120.524393-171509723 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006412 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-28 13:06:29.060512) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-28 13:06:29.060858) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-28 13:06:29.102691) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 13:06:29.103014) ========= 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=3e14eba40af1795cf0357910000001c3-1451332120.524393-171509723 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004595 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 13:06:29.168914) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-28 13:06:29.169319) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-28 13:06:29.169795) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 13:06:29.170228) ========= 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=3e14eba40af1795cf0357910000001c3-1451332120.524393-171509723 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-28 13:06:30-- 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% 35.6M=0s 2015-12-28 13:06:30 (35.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.146102 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 13:06:29.330270) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 13:06:29.330643) ========= 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=3e14eba40af1795cf0357910000001c3-1451332120.524393-171509723 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021005 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 13:06:29.380489) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 13:06:29.380858) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 4413def26994 --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 4413def26994 --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=3e14eba40af1795cf0357910000001c3-1451332120.524393-171509723 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-28 13:06:30,567 Setting DEBUG logging. 2015-12-28 13:06:30,567 attempt 1/10 2015-12-28 13:06:30,567 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/4413def26994?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-28 13:06:30,819 unpacking tar archive at: mozilla-beta-4413def26994/testing/mozharness/ program finished with exit code 0 elapsedTime=0.533964 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 13:06:29.928631) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-28 13:06:29.928945) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-28 13:06:29.939500) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-28 13:06:29.939916) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-28 13:06:29.940448) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2015-12-28 13:06:29.940741) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=3e14eba40af1795cf0357910000001c3-1451332120.524393-171509723 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:06:31 INFO - MultiFileLogger online at 20151228 13:06:31 in /builds/slave/test-pgo 13:06:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 13:06:31 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 13:06:31 INFO - {'append_to_log': False, 13:06:31 INFO - 'base_work_dir': '/builds/slave/test-pgo', 13:06:31 INFO - 'blob_upload_branch': 'Mozilla-Beta', 13:06:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 13:06:31 INFO - 'branch': 'Mozilla-Beta', 13:06:31 INFO - 'buildbot_json_path': 'buildprops.json', 13:06:31 INFO - 'config_files': ('talos/linux_config.py',), 13:06:31 INFO - 'default_actions': ('clobber', 13:06:31 INFO - 'read-buildbot-config', 13:06:31 INFO - 'download-and-extract', 13:06:31 INFO - 'populate-webroot', 13:06:31 INFO - 'create-virtualenv', 13:06:31 INFO - 'install', 13:06:31 INFO - 'run-tests'), 13:06:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:06:31 INFO - 'download_minidump_stackwalk': True, 13:06:31 INFO - 'download_symbols': 'ondemand', 13:06:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:06:31 INFO - 'tooltool.py': '/tools/tooltool.py', 13:06:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:06:31 INFO - '/tools/misc-python/virtualenv.py')}, 13:06:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:06:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:06:31 INFO - 'installer_path': 'installer.exe', 13:06:31 INFO - 'log_level': 'info', 13:06:31 INFO - 'log_name': 'talos', 13:06:31 INFO - 'log_to_console': True, 13:06:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:06:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:06:31 INFO - 'opt_config_files': (), 13:06:31 INFO - 'pip_index': False, 13:06:31 INFO - 'sps_profile': False, 13:06:31 INFO - 'sps_profile_interval': 0, 13:06:31 INFO - 'suite': 'dromaeojs', 13:06:31 INFO - 'system_bits': '32', 13:06:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:06:31 INFO - 'title': 'talos-linux64-ix-067', 13:06:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:06:31 INFO - 'use_talos_json': True, 13:06:31 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 13:06:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:06:31 INFO - 'work_dir': 'build'} 13:06:31 INFO - ##### 13:06:31 INFO - ##### Running clobber step. 13:06:31 INFO - ##### 13:06:31 INFO - Running pre-action listener: _resource_record_pre_action 13:06:31 INFO - Running main action method: clobber 13:06:31 INFO - rmtree: /builds/slave/test-pgo/build 13:06:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 13:06:31 INFO - Running post-action listener: _resource_record_post_action 13:06:31 INFO - ##### 13:06:31 INFO - ##### Running read-buildbot-config step. 13:06:31 INFO - ##### 13:06:31 INFO - Running pre-action listener: _resource_record_pre_action 13:06:31 INFO - Running main action method: read_buildbot_config 13:06:31 INFO - Using buildbot properties: 13:06:31 INFO - { 13:06:31 INFO - "properties": { 13:06:31 INFO - "buildnumber": 47, 13:06:31 INFO - "product": "firefox", 13:06:31 INFO - "script_repo_revision": "production", 13:06:31 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 13:06:31 INFO - "repository": "", 13:06:31 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 13:06:31 INFO - "buildid": "20151228105330", 13:06:31 INFO - "slavename": "talos-linux64-ix-067", 13:06:31 INFO - "pgo_build": "True", 13:06:31 INFO - "basedir": "/builds/slave/test-pgo", 13:06:31 INFO - "project": "", 13:06:31 INFO - "platform": "ubuntu64_hw", 13:06:31 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:06:31 INFO - "slavebuilddir": "test", 13:06:31 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 13:06:31 INFO - "branch": "mozilla-beta", 13:06:31 INFO - "repo_path": "releases/mozilla-beta", 13:06:31 INFO - "stage_platform": "linux64-pgo", 13:06:31 INFO - "builduid": "6d65666499d14a4a941a7590d4129318", 13:06:31 INFO - "revision": "4413def26994" 13:06:31 INFO - }, 13:06:31 INFO - "sourcestamp": { 13:06:31 INFO - "repository": "", 13:06:31 INFO - "hasPatch": false, 13:06:31 INFO - "project": "", 13:06:31 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 13:06:31 INFO - "changes": [ 13:06:31 INFO - { 13:06:31 INFO - "category": null, 13:06:31 INFO - "files": [ 13:06:31 INFO - { 13:06:31 INFO - "url": null, 13:06:31 INFO - "name": "http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1451328810/firefox-44.0.en-US.linux-x86_64.tar.bz2" 13:06:31 INFO - } 13:06:31 INFO - ], 13:06:31 INFO - "repository": "", 13:06:31 INFO - "rev": "4413def26994", 13:06:31 INFO - "who": "sendchange", 13:06:31 INFO - "when": 1451336772, 13:06:31 INFO - "number": 7397545, 13:06:31 INFO - "comments": "Bug 1232386 - Fix NativeObject::growSlotsStatic to recover from OOM. r=terrence a=ritu", 13:06:31 INFO - "project": "", 13:06:31 INFO - "at": "Mon 28 Dec 2015 13:06:12", 13:06:31 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 13:06:31 INFO - "revlink": "", 13:06:31 INFO - "properties": [ 13:06:31 INFO - [ 13:06:31 INFO - "buildid", 13:06:31 INFO - "20151228105330", 13:06:31 INFO - "Change" 13:06:31 INFO - ], 13:06:31 INFO - [ 13:06:31 INFO - "builduid", 13:06:31 INFO - "6d65666499d14a4a941a7590d4129318", 13:06:31 INFO - "Change" 13:06:31 INFO - ], 13:06:31 INFO - [ 13:06:31 INFO - "pgo_build", 13:06:31 INFO - "True", 13:06:31 INFO - "Change" 13:06:31 INFO - ] 13:06:31 INFO - ], 13:06:31 INFO - "revision": "4413def26994" 13:06:31 INFO - } 13:06:31 INFO - ], 13:06:31 INFO - "revision": "4413def26994" 13:06:31 INFO - } 13:06:31 INFO - } 13:06:31 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1451328810/firefox-44.0.en-US.linux-x86_64.tar.bz2. 13:06:31 INFO - Running post-action listener: _resource_record_post_action 13:06:31 INFO - ##### 13:06:31 INFO - ##### Running download-and-extract step. 13:06:31 INFO - ##### 13:06:31 INFO - Running pre-action listener: _resource_record_pre_action 13:06:31 INFO - Running main action method: download_and_extract 13:06:31 INFO - mkdir: /builds/slave/test-pgo/build/tests 13:06:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:06:31 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1451328810/test_packages.json 13:06:31 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1451328810/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 13:06:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1451328810/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 13:06:31 INFO - Downloaded 1270 bytes. 13:06:31 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 13:06:31 INFO - Using the following test package requirements: 13:06:31 INFO - {u'common': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip'], 13:06:31 INFO - u'cppunittest': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 13:06:31 INFO - u'firefox-44.0.en-US.linux-x86_64.cppunittest.tests.zip'], 13:06:31 INFO - u'jittest': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 13:06:31 INFO - u'jsshell-linux-x86_64.zip'], 13:06:31 INFO - u'mochitest': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 13:06:31 INFO - u'firefox-44.0.en-US.linux-x86_64.mochitest.tests.zip'], 13:06:31 INFO - u'mozbase': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip'], 13:06:31 INFO - u'reftest': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 13:06:31 INFO - u'firefox-44.0.en-US.linux-x86_64.reftest.tests.zip'], 13:06:31 INFO - u'talos': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 13:06:31 INFO - u'firefox-44.0.en-US.linux-x86_64.talos.tests.zip'], 13:06:31 INFO - u'web-platform': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 13:06:31 INFO - u'firefox-44.0.en-US.linux-x86_64.web-platform.tests.zip'], 13:06:31 INFO - u'webapprt': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip'], 13:06:31 INFO - u'xpcshell': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 13:06:31 INFO - u'firefox-44.0.en-US.linux-x86_64.xpcshell.tests.zip']} 13:06:31 INFO - Downloading packages: [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:06:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:06:31 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1451328810/firefox-44.0.en-US.linux-x86_64.common.tests.zip 13:06:31 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1451328810/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 13:06:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1451328810/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 13:06:32 INFO - Downloaded 22571829 bytes. 13:06:32 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 13:06:32 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip 13:06:32 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 13:06:33 INFO - Return code: 0 13:06:33 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 13:06:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:06:33 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1451328810/firefox-44.0.en-US.linux-x86_64.common.tests.zip 13:06:33 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1451328810/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 13:06:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1451328810/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 13:06:34 INFO - Downloaded 22571829 bytes. 13:06:34 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 13:06:34 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip 13:06:34 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 13:06:35 INFO - Return code: 0 13:06:35 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')]} 13:06:35 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1451328810/firefox-44.0.en-US.linux-x86_64.talos.tests.zip 13:06:35 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1451328810/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 13:06:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1451328810/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 13:06:37 INFO - Downloaded 11131970 bytes. 13:06:37 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 13:06:37 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.talos.tests.zip 13:06:37 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 13:06:38 INFO - Return code: 0 13:06:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:06:38 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1451328810/firefox-44.0.en-US.linux-x86_64.tar.bz2 13:06:38 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1451328810/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 13:06:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1451328810/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 13:06:40 INFO - Downloaded 56623257 bytes. 13:06:40 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1451328810/firefox-44.0.en-US.linux-x86_64.tar.bz2 13:06:40 INFO - mkdir: /builds/slave/test-pgo/properties 13:06:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 13:06:40 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 13:06:40 INFO - Contents: 13:06:40 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1451328810/firefox-44.0.en-US.linux-x86_64.tar.bz2 13:06:40 INFO - Running post-action listener: _resource_record_post_action 13:06:40 INFO - Running post-action listener: set_extra_try_arguments 13:06:40 INFO - ##### 13:06:40 INFO - ##### Running populate-webroot step. 13:06:40 INFO - ##### 13:06:40 INFO - Running pre-action listener: _resource_record_pre_action 13:06:40 INFO - Running main action method: populate_webroot 13:06:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:06:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:06:40 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 13:06:40 INFO - '../fennec_ids.txt'], 13:06:40 INFO - 'tests': ['tcheck2']}, 13:06:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:06:40 INFO - '--tppagecycles', 13:06:40 INFO - '7'], 13:06:40 INFO - 'tests': ['tsvgm']}}, 13:06:40 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 13:06:40 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 13:06:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:06:40 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:06:40 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 13:06:40 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:06:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:06:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:06:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:06:40 INFO - 'talos_options': ['--e10s'], 13:06:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:06:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:06:40 INFO - 'tests': ['damp', 'tps']}, 13:06:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:06:40 INFO - 'talos_options': ['--e10s'], 13:06:40 INFO - 'tests': ['damp', 'tps']}, 13:06:40 INFO - 'g3': {'tests': ['dromaeo_dom']}, 13:06:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:06:40 INFO - 'other': {'tests': ['a11yr', 13:06:40 INFO - 'ts_paint', 13:06:40 INFO - 'tpaint', 13:06:40 INFO - 'sessionrestore', 13:06:40 INFO - 'sessionrestore_no_auto_restore']}, 13:06:40 INFO - 'other-e10s': {'talos_options': ['--e10s'], 13:06:40 INFO - 'tests': ['a11yr', 13:06:40 INFO - 'ts_paint', 13:06:40 INFO - 'tpaint', 13:06:40 INFO - 'sessionrestore', 13:06:40 INFO - 'sessionrestore_no_auto_restore']}, 13:06:40 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 13:06:40 INFO - 'tests': ['a11yr', 13:06:40 INFO - 'ts_paint', 13:06:40 INFO - 'tpaint', 13:06:40 INFO - 'sessionrestore', 13:06:40 INFO - 'sessionrestore_no_auto_restore']}, 13:06:40 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 13:06:40 INFO - 'tests': ['a11yr', 13:06:40 INFO - 'ts_paint', 13:06:40 INFO - 'tpaint', 13:06:40 INFO - 'sessionrestore', 13:06:40 INFO - 'sessionrestore_no_auto_restore']}, 13:06:40 INFO - 'other_l64': {'tests': ['a11yr', 13:06:40 INFO - 'ts_paint', 13:06:40 INFO - 'tpaint', 13:06:40 INFO - 'sessionrestore', 13:06:40 INFO - 'sessionrestore_no_auto_restore']}, 13:06:40 INFO - 'other_nol64': {'tests': ['a11yr', 13:06:40 INFO - 'ts_paint', 13:06:40 INFO - 'tpaint', 13:06:40 INFO - 'sessionrestore', 13:06:40 INFO - 'sessionrestore_no_auto_restore']}, 13:06:40 INFO - 'svgr': {'tests': ['tsvgx', 13:06:40 INFO - 'tsvgr_opacity', 13:06:40 INFO - 'tart', 13:06:40 INFO - 'tscrollx', 13:06:40 INFO - 'cart']}, 13:06:40 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 13:06:40 INFO - 'tests': ['tsvgx', 13:06:40 INFO - 'tsvgr_opacity', 13:06:40 INFO - 'tart', 13:06:40 INFO - 'tscrollx', 13:06:40 INFO - 'cart']}, 13:06:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:06:40 INFO - 'tests': ['tp5o']}, 13:06:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:06:40 INFO - 'talos_options': ['--e10s'], 13:06:40 INFO - 'tests': ['tp5o']}, 13:06:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:06:40 INFO - 'talos_options': ['--xperf_path', 13:06:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:06:40 INFO - 'tests': ['tp5n']}, 13:06:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:06:40 INFO - 'talos_options': ['--e10s', 13:06:40 INFO - '--xperf_path', 13:06:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:06:40 INFO - 'tests': ['tp5n']}}, 13:06:40 INFO - 'talos.zip': {'path': '', 13:06:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:06:40 INFO - Running post-action listener: _resource_record_post_action 13:06:40 INFO - ##### 13:06:40 INFO - ##### Running create-virtualenv step. 13:06:40 INFO - ##### 13:06:40 INFO - Running pre-action listener: _resource_record_pre_action 13:06:40 INFO - Running main action method: create_virtualenv 13:06:40 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 13:06:40 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 13:06:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 13:06:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:06:41 INFO - Using real prefix '/usr' 13:06:41 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 13:06:41 INFO - Installing distribute.............................................................................................................................................................................................done. 13:06:43 INFO - Installing pip.................done. 13:06:43 INFO - Return code: 0 13:06:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 13:06:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:06:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:06:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:06:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:06:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:43 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f93eb971f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x151c600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ab350>, '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 0x15ac250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15ac6e0>, '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': '3e14eba40af1795cf0357910000001c3-1451332120.524393-171509723', '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 13:06:43 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 13:06:43 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 13:06:43 INFO - Using env: {'DISPLAY': ':0', 13:06:43 INFO - 'HOME': '/home/cltbld', 13:06:43 INFO - 'LANG': 'en_US.UTF-8', 13:06:43 INFO - 'LANGUAGE': 'en_US:en', 13:06:43 INFO - 'LOGNAME': 'cltbld', 13:06:43 INFO - 'MAIL': '/var/mail/cltbld', 13:06:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:06:43 INFO - 'MOZ_NO_REMOTE': '1', 13:06:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:06:43 INFO - 'NO_EM_RESTART': '1', 13:06:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:06:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:06:43 INFO - 'PWD': '/builds/slave/test-pgo', 13:06:43 INFO - 'SHELL': '/bin/bash', 13:06:43 INFO - 'SHLVL': '1', 13:06:43 INFO - 'TERM': 'linux', 13:06:43 INFO - 'TMOUT': '86400', 13:06:43 INFO - 'USER': 'cltbld', 13:06:43 INFO - 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1451332120.524393-171509723', 13:06:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:06:43 INFO - '_': '/tools/buildbot/bin/python'} 13:06:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:06:43 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 13:06:43 INFO - Cleaning up... 13:06:43 INFO - Return code: 0 13:06:43 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 13:06:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:06:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:06:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:06:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:06:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:43 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f93eb971f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x151c600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ab350>, '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 0x15ac250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15ac6e0>, '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': '3e14eba40af1795cf0357910000001c3-1451332120.524393-171509723', '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 13:06:43 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 13:06:43 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 13:06:43 INFO - Using env: {'DISPLAY': ':0', 13:06:43 INFO - 'HOME': '/home/cltbld', 13:06:43 INFO - 'LANG': 'en_US.UTF-8', 13:06:43 INFO - 'LANGUAGE': 'en_US:en', 13:06:43 INFO - 'LOGNAME': 'cltbld', 13:06:43 INFO - 'MAIL': '/var/mail/cltbld', 13:06:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:06:43 INFO - 'MOZ_NO_REMOTE': '1', 13:06:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:06:43 INFO - 'NO_EM_RESTART': '1', 13:06:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:06:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:06:43 INFO - 'PWD': '/builds/slave/test-pgo', 13:06:43 INFO - 'SHELL': '/bin/bash', 13:06:43 INFO - 'SHLVL': '1', 13:06:43 INFO - 'TERM': 'linux', 13:06:43 INFO - 'TMOUT': '86400', 13:06:43 INFO - 'USER': 'cltbld', 13:06:43 INFO - 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1451332120.524393-171509723', 13:06:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:06:43 INFO - '_': '/tools/buildbot/bin/python'} 13:06:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:06:43 INFO - Downloading/unpacking psutil>=0.7.1 13:06:43 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 13:06:43 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 13:06:43 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 13:06:43 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 13:06:43 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 13:06:43 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 13:06:45 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 13:06:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 13:06:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 13:06:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:06:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:06:45 INFO - Installing collected packages: psutil 13:06:45 INFO - Running setup.py install for psutil 13:06:45 INFO - building 'psutil._psutil_linux' extension 13:06:45 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 13:06:45 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 13:06:45 INFO - building 'psutil._psutil_posix' extension 13:06:45 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 13:06:46 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 13:06:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:06:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:06:46 INFO - Successfully installed psutil 13:06:46 INFO - Cleaning up... 13:06:46 INFO - Return code: 0 13:06:46 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 13:06:46 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')]} 13:06:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:06:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:46 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')]} 13:06:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:06:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:46 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 0x7f93eb971f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x151c600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ab350>, '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 0x15ac250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15ac6e0>, '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': '3e14eba40af1795cf0357910000001c3-1451332120.524393-171509723', '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 13:06:46 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 13:06:46 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 13:06:46 INFO - Using env: {'DISPLAY': ':0', 13:06:46 INFO - 'HOME': '/home/cltbld', 13:06:46 INFO - 'LANG': 'en_US.UTF-8', 13:06:46 INFO - 'LANGUAGE': 'en_US:en', 13:06:46 INFO - 'LOGNAME': 'cltbld', 13:06:46 INFO - 'MAIL': '/var/mail/cltbld', 13:06:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:06:46 INFO - 'MOZ_NO_REMOTE': '1', 13:06:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:06:46 INFO - 'NO_EM_RESTART': '1', 13:06:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:06:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:06:46 INFO - 'PWD': '/builds/slave/test-pgo', 13:06:46 INFO - 'SHELL': '/bin/bash', 13:06:46 INFO - 'SHLVL': '1', 13:06:46 INFO - 'TERM': 'linux', 13:06:46 INFO - 'TMOUT': '86400', 13:06:46 INFO - 'USER': 'cltbld', 13:06:46 INFO - 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1451332120.524393-171509723', 13:06:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:06:46 INFO - '_': '/tools/buildbot/bin/python'} 13:06:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:06:46 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:06:46 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 13:06:46 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 13:06:46 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 13:06:46 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 13:06:46 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 13:06:46 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 13:06:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:06:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 13:06:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:06:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:06:48 INFO - Installing collected packages: mozsystemmonitor 13:06:48 INFO - Running setup.py install for mozsystemmonitor 13:06:48 INFO - Successfully installed mozsystemmonitor 13:06:48 INFO - Cleaning up... 13:06:48 INFO - Return code: 0 13:06:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 13:06:48 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')]} 13:06:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:06:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:48 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')]} 13:06:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:06:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:48 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 0x7f93eb971f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x151c600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ab350>, '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 0x15ac250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15ac6e0>, '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': '3e14eba40af1795cf0357910000001c3-1451332120.524393-171509723', '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 13:06:48 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 13:06:48 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 13:06:48 INFO - Using env: {'DISPLAY': ':0', 13:06:48 INFO - 'HOME': '/home/cltbld', 13:06:48 INFO - 'LANG': 'en_US.UTF-8', 13:06:48 INFO - 'LANGUAGE': 'en_US:en', 13:06:48 INFO - 'LOGNAME': 'cltbld', 13:06:48 INFO - 'MAIL': '/var/mail/cltbld', 13:06:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:06:48 INFO - 'MOZ_NO_REMOTE': '1', 13:06:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:06:48 INFO - 'NO_EM_RESTART': '1', 13:06:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:06:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:06:48 INFO - 'PWD': '/builds/slave/test-pgo', 13:06:48 INFO - 'SHELL': '/bin/bash', 13:06:48 INFO - 'SHLVL': '1', 13:06:48 INFO - 'TERM': 'linux', 13:06:48 INFO - 'TMOUT': '86400', 13:06:48 INFO - 'USER': 'cltbld', 13:06:48 INFO - 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1451332120.524393-171509723', 13:06:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:06:48 INFO - '_': '/tools/buildbot/bin/python'} 13:06:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:06:48 INFO - Downloading/unpacking blobuploader==1.2.4 13:06:48 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 13:06:48 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 13:06:48 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 13:06:48 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 13:06:48 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 13:06:48 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 13:06:50 INFO - Downloading blobuploader-1.2.4.tar.gz 13:06:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 13:06:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:06:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:06:50 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 13:06:50 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 13:06:50 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 13:06:50 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 13:06:50 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 13:06:50 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 13:06:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 13:06:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 13:06:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:06:50 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 13:06:50 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 13:06:50 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 13:06:50 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 13:06:50 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 13:06:50 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 13:06:50 INFO - Downloading docopt-0.6.1.tar.gz 13:06:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 13:06:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 13:06:51 INFO - Installing collected packages: blobuploader, requests, docopt 13:06:51 INFO - Running setup.py install for blobuploader 13:06:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:06:51 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 13:06:51 INFO - Running setup.py install for requests 13:06:51 INFO - Running setup.py install for docopt 13:06:51 INFO - Successfully installed blobuploader requests docopt 13:06:51 INFO - Cleaning up... 13:06:51 INFO - Return code: 0 13:06:51 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:06:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:06:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:06:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:06:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:06:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:51 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 0x7f93eb971f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x151c600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ab350>, '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 0x15ac250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15ac6e0>, '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': '3e14eba40af1795cf0357910000001c3-1451332120.524393-171509723', '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 13:06:51 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 13:06:51 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 13:06:51 INFO - Using env: {'DISPLAY': ':0', 13:06:51 INFO - 'HOME': '/home/cltbld', 13:06:51 INFO - 'LANG': 'en_US.UTF-8', 13:06:51 INFO - 'LANGUAGE': 'en_US:en', 13:06:51 INFO - 'LOGNAME': 'cltbld', 13:06:51 INFO - 'MAIL': '/var/mail/cltbld', 13:06:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:06:51 INFO - 'MOZ_NO_REMOTE': '1', 13:06:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:06:51 INFO - 'NO_EM_RESTART': '1', 13:06:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:06:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:06:51 INFO - 'PWD': '/builds/slave/test-pgo', 13:06:51 INFO - 'SHELL': '/bin/bash', 13:06:51 INFO - 'SHLVL': '1', 13:06:51 INFO - 'TERM': 'linux', 13:06:51 INFO - 'TMOUT': '86400', 13:06:51 INFO - 'USER': 'cltbld', 13:06:51 INFO - 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1451332120.524393-171509723', 13:06:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:06:51 INFO - '_': '/tools/buildbot/bin/python'} 13:06:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:06:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:06:51 INFO - Running setup.py (path:/tmp/pip-A6k0C3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:06:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:06:51 INFO - Running setup.py (path:/tmp/pip-Wgzj9s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:06:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:06:51 INFO - Running setup.py (path:/tmp/pip-DyQTn_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:06:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:06:52 INFO - Running setup.py (path:/tmp/pip-fq0x7l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:06:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 13:06:52 INFO - Running setup.py (path:/tmp/pip-rvk54d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 13:06:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:06:52 INFO - Running setup.py (path:/tmp/pip-ciDnvF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:06:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:06:52 INFO - Running setup.py (path:/tmp/pip-noP4nv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:06:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:06:52 INFO - Running setup.py (path:/tmp/pip-qFXtt8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:06:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 13:06:52 INFO - Running setup.py (path:/tmp/pip-MMO9bd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 13:06:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 13:06:52 INFO - Running setup.py (path:/tmp/pip-mG9gtQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 13:06:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:06:52 INFO - Running setup.py (path:/tmp/pip-yO1Ret-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:06:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:06:52 INFO - Running setup.py (path:/tmp/pip-Af0ND9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:06:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:06:52 INFO - Running setup.py (path:/tmp/pip-Ktgc0x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:06:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:06:52 INFO - Running setup.py (path:/tmp/pip-2JKxV2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:06:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:06:52 INFO - Running setup.py (path:/tmp/pip-rv4eRl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:06:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 13:06:52 INFO - Running setup.py (path:/tmp/pip-Oc9BiE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 13:06:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 13:06:53 INFO - Running setup.py (path:/tmp/pip-iwVX_Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 13:06:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:06:53 INFO - Running setup.py install for manifestparser 13:06:53 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 13:06:53 INFO - Running setup.py install for mozcrash 13:06:53 INFO - Running setup.py install for mozdebug 13:06:53 INFO - Running setup.py install for mozdevice 13:06:53 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 13:06:53 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 13:06:53 INFO - Running setup.py install for mozfile 13:06:53 INFO - Running setup.py install for mozhttpd 13:06:53 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 13:06:53 INFO - Running setup.py install for mozinfo 13:06:53 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 13:06:53 INFO - Running setup.py install for mozInstall 13:06:53 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 13:06:53 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 13:06:53 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 13:06:53 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 13:06:53 INFO - Running setup.py install for mozleak 13:06:53 INFO - Running setup.py install for mozlog 13:06:54 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 13:06:54 INFO - Running setup.py install for moznetwork 13:06:54 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 13:06:54 INFO - Running setup.py install for mozprocess 13:06:54 INFO - Running setup.py install for mozprofile 13:06:54 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 13:06:54 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 13:06:54 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 13:06:54 INFO - Running setup.py install for mozrunner 13:06:54 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 13:06:54 INFO - Running setup.py install for mozscreenshot 13:06:54 INFO - Running setup.py install for moztest 13:06:54 INFO - Running setup.py install for mozversion 13:06:54 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 13:06:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:06:54 INFO - Cleaning up... 13:06:54 INFO - Return code: 0 13:06:54 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:06:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:06:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:06:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:06:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:06:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:54 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f93eb971f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x151c600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ab350>, '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 0x15ac250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15ac6e0>, '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': '3e14eba40af1795cf0357910000001c3-1451332120.524393-171509723', '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 13:06:54 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 13:06:54 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 13:06:54 INFO - Using env: {'DISPLAY': ':0', 13:06:54 INFO - 'HOME': '/home/cltbld', 13:06:54 INFO - 'LANG': 'en_US.UTF-8', 13:06:54 INFO - 'LANGUAGE': 'en_US:en', 13:06:54 INFO - 'LOGNAME': 'cltbld', 13:06:54 INFO - 'MAIL': '/var/mail/cltbld', 13:06:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:06:54 INFO - 'MOZ_NO_REMOTE': '1', 13:06:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:06:54 INFO - 'NO_EM_RESTART': '1', 13:06:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:06:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:06:54 INFO - 'PWD': '/builds/slave/test-pgo', 13:06:54 INFO - 'SHELL': '/bin/bash', 13:06:54 INFO - 'SHLVL': '1', 13:06:54 INFO - 'TERM': 'linux', 13:06:54 INFO - 'TMOUT': '86400', 13:06:54 INFO - 'USER': 'cltbld', 13:06:54 INFO - 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1451332120.524393-171509723', 13:06:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:06:54 INFO - '_': '/tools/buildbot/bin/python'} 13:06:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:06:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:06:55 INFO - Running setup.py (path:/tmp/pip-Avtvh7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:06:55 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)) 13:06:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:06:55 INFO - Running setup.py (path:/tmp/pip-CJNY3V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:06:55 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)) 13:06:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:06:55 INFO - Running setup.py (path:/tmp/pip-da46jx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:06:55 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)) 13:06:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:06:55 INFO - Running setup.py (path:/tmp/pip-gAaBIf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:06:55 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)) 13:06:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 13:06:55 INFO - Running setup.py (path:/tmp/pip-KsLF7M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 13:06:55 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)) 13:06:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:06:55 INFO - Running setup.py (path:/tmp/pip-DDD7QC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:06:55 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)) 13:06:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:06:55 INFO - Running setup.py (path:/tmp/pip-h5UmNY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:06:55 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)) 13:06:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:06:55 INFO - Running setup.py (path:/tmp/pip-LBzzqA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:06:55 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)) 13:06:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 13:06:55 INFO - Running setup.py (path:/tmp/pip-3RW1be-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 13:06:55 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)) 13:06:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 13:06:55 INFO - Running setup.py (path:/tmp/pip-5OjRAS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 13:06:55 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)) 13:06:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:06:55 INFO - Running setup.py (path:/tmp/pip-zTvIyI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:06:55 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)) 13:06:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:06:55 INFO - Running setup.py (path:/tmp/pip-m6515Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:06:55 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)) 13:06:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:06:55 INFO - Running setup.py (path:/tmp/pip-LGshrt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:06:56 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)) 13:06:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:06:56 INFO - Running setup.py (path:/tmp/pip-aAwXLJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:06:56 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)) 13:06:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:06:56 INFO - Running setup.py (path:/tmp/pip-cHQsDY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:06:56 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)) 13:06:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 13:06:56 INFO - Running setup.py (path:/tmp/pip-R6LGg3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 13:06:56 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)) 13:06:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 13:06:56 INFO - Running setup.py (path:/tmp/pip-BOtD7v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 13:06:56 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)) 13:06:56 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)) 13:06:56 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)) 13:06:56 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)) 13:06:56 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)) 13:06:56 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)) 13:06:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 13:06:56 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 13:06:56 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 13:06:56 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 13:06:56 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 13:06:56 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 13:06:56 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 13:06:57 INFO - Downloading blessings-1.5.1.tar.gz 13:06:57 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 13:06:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 13:06:58 INFO - Installing collected packages: blessings 13:06:58 INFO - Running setup.py install for blessings 13:06:58 INFO - Successfully installed blessings 13:06:58 INFO - Cleaning up... 13:06:58 INFO - Return code: 0 13:06:58 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 13:06:58 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 13:06:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 13:06:58 INFO - Reading from file tmpfile_stdout 13:06:58 INFO - Current package versions: 13:06:58 INFO - argparse == 1.2.1 13:06:58 INFO - blessings == 1.5.1 13:06:58 INFO - blobuploader == 1.2.4 13:06:58 INFO - docopt == 0.6.1 13:06:58 INFO - manifestparser == 1.1 13:06:58 INFO - mozInstall == 1.12 13:06:58 INFO - mozcrash == 0.16 13:06:58 INFO - mozdebug == 0.1 13:06:58 INFO - mozdevice == 0.46 13:06:58 INFO - mozfile == 1.2 13:06:58 INFO - mozhttpd == 0.7 13:06:58 INFO - mozinfo == 0.8 13:06:58 INFO - mozleak == 0.1 13:06:58 INFO - mozlog == 3.0 13:06:58 INFO - moznetwork == 0.27 13:06:58 INFO - mozprocess == 0.22 13:06:58 INFO - mozprofile == 0.27 13:06:58 INFO - mozrunner == 6.11 13:06:58 INFO - mozscreenshot == 0.1 13:06:58 INFO - mozsystemmonitor == 0.0 13:06:58 INFO - moztest == 0.7 13:06:58 INFO - mozversion == 1.4 13:06:58 INFO - psutil == 3.1.1 13:06:58 INFO - requests == 1.2.3 13:06:58 INFO - wsgiref == 0.1.2 13:06:58 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:06:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:06:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:06:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:06:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:06:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f93eb971f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x151c600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ab350>, '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 0x15ac250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15ac6e0>, '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': '3e14eba40af1795cf0357910000001c3-1451332120.524393-171509723', '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 13:06:58 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 13:06:58 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 13:06:58 INFO - Using env: {'DISPLAY': ':0', 13:06:58 INFO - 'HOME': '/home/cltbld', 13:06:58 INFO - 'LANG': 'en_US.UTF-8', 13:06:58 INFO - 'LANGUAGE': 'en_US:en', 13:06:58 INFO - 'LOGNAME': 'cltbld', 13:06:58 INFO - 'MAIL': '/var/mail/cltbld', 13:06:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:06:58 INFO - 'MOZ_NO_REMOTE': '1', 13:06:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:06:58 INFO - 'NO_EM_RESTART': '1', 13:06:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:06:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:06:58 INFO - 'PWD': '/builds/slave/test-pgo', 13:06:58 INFO - 'SHELL': '/bin/bash', 13:06:58 INFO - 'SHLVL': '1', 13:06:58 INFO - 'TERM': 'linux', 13:06:58 INFO - 'TMOUT': '86400', 13:06:58 INFO - 'USER': 'cltbld', 13:06:58 INFO - 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1451332120.524393-171509723', 13:06:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:06:58 INFO - '_': '/tools/buildbot/bin/python'} 13:06:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:06:58 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)) 13:06:58 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)) 13:06:58 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)) 13:06:58 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)) 13:06:58 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)) 13:06:58 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)) 13:06:58 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)) 13:06:58 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)) 13:06:58 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)) 13:06:58 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)) 13:06:58 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)) 13:06:58 INFO - Cleaning up... 13:06:58 INFO - Return code: 0 13:06:58 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 13:06:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:06:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:06:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:06:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:06:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f93eb971f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x151c600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ab350>, '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 0x15ac250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15ac6e0>, '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': '3e14eba40af1795cf0357910000001c3-1451332120.524393-171509723', '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 13:06:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 13:06:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:06:58 INFO - Using env: {'DISPLAY': ':0', 13:06:58 INFO - 'HOME': '/home/cltbld', 13:06:58 INFO - 'LANG': 'en_US.UTF-8', 13:06:58 INFO - 'LANGUAGE': 'en_US:en', 13:06:58 INFO - 'LOGNAME': 'cltbld', 13:06:58 INFO - 'MAIL': '/var/mail/cltbld', 13:06:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:06:58 INFO - 'MOZ_NO_REMOTE': '1', 13:06:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:06:58 INFO - 'NO_EM_RESTART': '1', 13:06:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:06:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:06:58 INFO - 'PWD': '/builds/slave/test-pgo', 13:06:58 INFO - 'SHELL': '/bin/bash', 13:06:58 INFO - 'SHLVL': '1', 13:06:58 INFO - 'TERM': 'linux', 13:06:58 INFO - 'TMOUT': '86400', 13:06:58 INFO - 'USER': 'cltbld', 13:06:58 INFO - 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1451332120.524393-171509723', 13:06:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:06:58 INFO - '_': '/tools/buildbot/bin/python'} 13:06:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:06:58 INFO - Downloading/unpacking jsonschema 13:06:58 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 13:06:58 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 13:06:58 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 13:06:58 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 13:06:58 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 13:06:58 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 13:07:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:07:00 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 13:07:00 INFO - Downloading/unpacking functools32 (from jsonschema) 13:07:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:07:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:07:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:07:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:07:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:07:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:07:00 INFO - Downloading functools32-3.2.3-2.tar.gz 13:07:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 13:07:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 13:07:00 INFO - warning: no files found matching '*.txt' 13:07:00 INFO - no previously-included directories found matching 'build' 13:07:00 INFO - no previously-included directories found matching 'dist' 13:07:00 INFO - no previously-included directories found matching '.git*' 13:07:00 INFO - Installing collected packages: jsonschema, functools32 13:07:00 INFO - Running setup.py install for functools32 13:07:00 INFO - warning: no files found matching '*.txt' 13:07:00 INFO - no previously-included directories found matching 'build' 13:07:00 INFO - no previously-included directories found matching 'dist' 13:07:00 INFO - no previously-included directories found matching '.git*' 13:07:00 INFO - Successfully installed jsonschema functools32 13:07:00 INFO - Cleaning up... 13:07:00 INFO - Return code: 0 13:07:00 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 13:07:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:07:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:07:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:07:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:07:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:00 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f93eb971f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x151c600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ab350>, '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 0x15ac250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15ac6e0>, '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': '3e14eba40af1795cf0357910000001c3-1451332120.524393-171509723', '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 13:07:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 13:07:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 13:07:00 INFO - Using env: {'DISPLAY': ':0', 13:07:00 INFO - 'HOME': '/home/cltbld', 13:07:00 INFO - 'LANG': 'en_US.UTF-8', 13:07:00 INFO - 'LANGUAGE': 'en_US:en', 13:07:00 INFO - 'LOGNAME': 'cltbld', 13:07:00 INFO - 'MAIL': '/var/mail/cltbld', 13:07:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:07:00 INFO - 'MOZ_NO_REMOTE': '1', 13:07:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:07:00 INFO - 'NO_EM_RESTART': '1', 13:07:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:07:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:07:00 INFO - 'PWD': '/builds/slave/test-pgo', 13:07:00 INFO - 'SHELL': '/bin/bash', 13:07:00 INFO - 'SHLVL': '1', 13:07:00 INFO - 'TERM': 'linux', 13:07:00 INFO - 'TMOUT': '86400', 13:07:00 INFO - 'USER': 'cltbld', 13:07:00 INFO - 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1451332120.524393-171509723', 13:07:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:07:00 INFO - '_': '/tools/buildbot/bin/python'} 13:07:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:07:01 INFO - Downloading/unpacking flake8 13:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:07:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:07:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:07:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:07:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:07:02 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:07:02 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 13:07:02 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:07:02 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 13:07:02 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 13:07:02 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 13:07:02 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 13:07:02 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 13:07:02 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 13:07:03 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:07:03 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 13:07:03 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:07:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:07:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:07:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:07:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:07:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:07:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:07:03 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 13:07:03 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:07:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:07:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:07:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:07:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:07:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:07:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:07:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 13:07:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 13:07:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:07:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:07:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:07:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:07:03 INFO - no previously-included directories found matching 'docs/_build' 13:07:03 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:07:03 INFO - Running setup.py install for pep8 13:07:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:07:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:07:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:07:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:07:03 INFO - no previously-included directories found matching 'docs/_build' 13:07:03 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 13:07:03 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:07:03 INFO - Cleaning up... 13:07:03 INFO - Return code: 0 13:07:03 INFO - Running post-action listener: _resource_record_post_action 13:07:03 INFO - Running post-action listener: _start_resource_monitoring 13:07:03 INFO - Starting resource monitoring. 13:07:03 INFO - ##### 13:07:03 INFO - ##### Running install step. 13:07:03 INFO - ##### 13:07:03 INFO - Running pre-action listener: _resource_record_pre_action 13:07:03 INFO - Running main action method: install 13:07:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 13:07:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 13:07:04 INFO - Reading from file tmpfile_stdout 13:07:04 INFO - Detecting whether we're running mozinstall >=1.0... 13:07:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 13:07:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 13:07:04 INFO - Reading from file tmpfile_stdout 13:07:04 INFO - Output received: 13:07:04 INFO - Usage: mozinstall [options] installer 13:07:04 INFO - Options: 13:07:04 INFO - -h, --help show this help message and exit 13:07:04 INFO - -d DEST, --destination=DEST 13:07:04 INFO - Directory to install application into. [default: 13:07:04 INFO - "/builds/slave/test-pgo"] 13:07:04 INFO - --app=APP Application being installed. [default: firefox] 13:07:04 INFO - mkdir: /builds/slave/test-pgo/build/application 13:07:04 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'] 13:07:04 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 13:07:18 INFO - Reading from file tmpfile_stdout 13:07:18 INFO - Output received: 13:07:18 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 13:07:18 INFO - Running post-action listener: _resource_record_post_action 13:07:18 INFO - ##### 13:07:18 INFO - ##### Running run-tests step. 13:07:18 INFO - ##### 13:07:18 INFO - Running pre-action listener: _resource_record_pre_action 13:07:18 INFO - Running main action method: run_tests 13:07:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 13:07:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 13:07:18 INFO - Python 2.7.3 13:07:18 INFO - Return code: 0 13:07:18 INFO - grabbing minidump binary from tooltool 13:07:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:07:18 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 0x15ab350>, '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 0x15ac250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15ac6e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 13:07:18 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 13:07:18 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 13:07:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:07:18 INFO - Return code: 0 13:07:18 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 13:07:18 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 13:07:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 13:07:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 13:07:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 13:07:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 13:07:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 13:07:19 INFO - Return code: 0 13:07:19 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/1451328810/firefox-44.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 13:07:19 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/1451328810/firefox-44.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-067 --webServer localhost 13:07:19 INFO - Using env: {'DISPLAY': ':0', 13:07:19 INFO - 'HOME': '/home/cltbld', 13:07:19 INFO - 'LANG': 'en_US.UTF-8', 13:07:19 INFO - 'LANGUAGE': 'en_US:en', 13:07:19 INFO - 'LOGNAME': 'cltbld', 13:07:19 INFO - 'MAIL': '/var/mail/cltbld', 13:07:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 13:07:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 13:07:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:07:19 INFO - 'MOZ_NO_REMOTE': '1', 13:07:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 13:07:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:07:19 INFO - 'NO_EM_RESTART': '1', 13:07:19 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:07:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:07:19 INFO - 'PWD': '/builds/slave/test-pgo', 13:07:19 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 13:07:19 INFO - 'SHELL': '/bin/bash', 13:07:19 INFO - 'SHLVL': '1', 13:07:19 INFO - 'TERM': 'linux', 13:07:19 INFO - 'TMOUT': '86400', 13:07:19 INFO - 'USER': 'cltbld', 13:07:19 INFO - 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1451332120.524393-171509723', 13:07:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:07:19 INFO - '_': '/tools/buildbot/bin/python'} 13:07:19 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/1451328810/firefox-44.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost'] with output_timeout 3600 13:07:19 INFO - mozversion INFO | application_buildid: 20151228105330 13:07:19 INFO - mozversion INFO | application_changeset: 4413def26994c535d29add8892df5cc50343c630 13:07:19 INFO - mozversion INFO | application_display_name: Nightly 13:07:19 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:07:19 INFO - mozversion INFO | application_name: Firefox 13:07:19 INFO - mozversion INFO | application_remotingname: firefox 13:07:19 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-beta 13:07:19 INFO - mozversion INFO | application_vendor: Mozilla 13:07:19 INFO - mozversion INFO | application_version: 44.0 13:07:19 INFO - mozversion INFO | platform_buildid: 20151228105330 13:07:19 INFO - mozversion INFO | platform_changeset: 4413def26994c535d29add8892df5cc50343c630 13:07:19 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-beta 13:07:19 INFO - mozversion INFO | platform_version: 44.0 13:07:19 INFO - 2015-12-28 13:07:19,525 DEBUG : using testdate: 1451336839 13:07:19 INFO - 2015-12-28 13:07:19,525 DEBUG : actual date: 1451336839 13:07:19 INFO - 2015-12-28 13:07:19,573 INFO : starting webserver on 'localhost:58079' 13:07:19 INFO - 2015-12-28 13:07:19,574 INFO : Starting test suite talos-linux64-ix-067 13:07:19 INFO - 2015-12-28 13:07:19,574 INFO : Starting test dromaeo_css 13:07:19 INFO - 2015-12-28 13:07:19,574 DEBUG : operating with platform_type : linux_ 13:07:19 INFO - 2015-12-28 13:07:19,575 INFO : Initialising browser for dromaeo_css test... 13:07:19 INFO - 2015-12-28 13:07:19,591 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQn9fgF/profile http://localhost:58079/getInfo.html 13:07:23 INFO - 2015-12-28 13:07:23,464 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:07:23 INFO - 2015-12-28 13:07:23,465 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:07:23 INFO - 2015-12-28 13:07:23,465 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 13:07:23 INFO - 2015-12-28 13:07:23,465 DEBUG : BROWSER_OUTPUT: __metrics 13:07:23 INFO - 2015-12-28 13:07:23,601 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] 13:07:24 INFO - 2015-12-28 13:07:24,817 INFO : Browser initialized. 13:07:24 INFO - 2015-12-28 13:07:24,818 INFO : Running cycle 1/1 for dromaeo_css test... 13:07:24 INFO - 2015-12-28 13:07:24,818 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQn9fgF/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:07:36 INFO - 2015-12-28 13:07:36,356 DEBUG : BROWSER_OUTPUT: RSS: Main: 128765952 13:07:36 INFO - 2015-12-28 13:07:36,356 DEBUG : BROWSER_OUTPUT: 13:08:28 INFO - 2015-12-28 13:08:28,141 DEBUG : BROWSER_OUTPUT: 1451336908140 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] 13:10:35 INFO - 2015-12-28 13:10:35,188 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58079/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58079/tests/dromaeo/cssquery-ext.html) 13:10:36 INFO - 2015-12-28 13:10:36,258 DEBUG : BROWSER_OUTPUT: RSS: Main: 237383680 13:10:36 INFO - 2015-12-28 13:10:36,258 DEBUG : BROWSER_OUTPUT: 13:13:38 INFO - 2015-12-28 13:13:38,309 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58079/tests/dromaeo/cssquery-ext.html (next: http://localhost:58079/tests/dromaeo/cssquery-jquery.html) 13:13:38 INFO - 2015-12-28 13:13:38,875 DEBUG : BROWSER_OUTPUT: RSS: Main: 209141760 13:13:38 INFO - 2015-12-28 13:13:38,875 DEBUG : BROWSER_OUTPUT: 13:16:40 INFO - 2015-12-28 13:16:40,604 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58079/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58079/tests/dromaeo/cssquery-mootools.html) 13:16:41 INFO - 2015-12-28 13:16:41,165 DEBUG : BROWSER_OUTPUT: RSS: Main: 207892480 13:16:41 INFO - 2015-12-28 13:16:41,165 DEBUG : BROWSER_OUTPUT: 13:19:42 INFO - 2015-12-28 13:19:42,833 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58079/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58079/tests/dromaeo/cssquery-prototype.html) 13:19:43 INFO - 2015-12-28 13:19:43,407 DEBUG : BROWSER_OUTPUT: RSS: Main: 195252224 13:19:43 INFO - 2015-12-28 13:19:43,407 DEBUG : BROWSER_OUTPUT: 13:22:45 INFO - 2015-12-28 13:22:45,680 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58079/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58079/tests/dromaeo/cssquery-yui.html) 13:22:46 INFO - 2015-12-28 13:22:46,246 DEBUG : BROWSER_OUTPUT: RSS: Main: 194805760 13:22:46 INFO - 2015-12-28 13:22:46,247 DEBUG : BROWSER_OUTPUT: 13:25:48 INFO - 2015-12-28 13:25:48,346 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58079/tests/dromaeo/cssquery-yui.html (next: http://localhost:58079/tests/dromaeo/cssquery-dojo.html) 13:25:48 INFO - 2015-12-28 13:25:48,592 DEBUG : BROWSER_OUTPUT: RSS: Main: 222642176 13:25:48 INFO - 2015-12-28 13:25:48,592 DEBUG : BROWSER_OUTPUT: 13:25:48 INFO - 2015-12-28 13:25:48,593 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:25:48 INFO - 2015-12-28 13:25:48,593 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:25:48 INFO - 2015-12-28 13:25:48,593 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:25:48 INFO - 2015-12-28 13:25:48,594 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:25:48 INFO - 2015-12-28 13:25:48,595 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3341.632420433752;3397.269587038786;3420.127867393814;3424.948625770612;3453.740969427292;5577.8605534861645;5607.579431542636;5614.326280846304;5617.269754931864;5617.831465056055;5601.131824567188;5660.915086273699;5666.5183459406;5672.17753425754;5672.205891175228;4970.701757894538;5130.794768209276;5150.072986862363;5176.456472070435;5192.454792246816;5131.692098474104;5136.794528218867;5153.6392452528335;5157.277981082651;5159.896802063975;5078.4921507849285;5100.260462232974;5151.459096794839;5151.871203219912;5161.251618515313;5094.949050509503;5131.61512886535;5254.3169387979315;5260.316158899319;5262.815801446931;5118.488151184889;5147.6654017488745;5166.044281807877;5189.273501709764;5191.273221748958;5245.842624721265;5254.0805359062015;5349.786008559653;5451.64564303319;5452.591055670801;6064.436504065855;6072.981358726227;6079.300880398767;6090.421409966046;6099.207103076572;6085.208922840046;6091.269047714259;6093.939060609381;6097.268327800648;6122.663253521055;5478.397376288605;5557.5831812613815;5584.832455026356;5703.201551782754;5712.11462223356;6010.519158467312;6199.690015499297;6201.844953876189;6209.844753881189;6211.09939058834;6027.246594175728;6063.181470501426;6065.514758819284;6072.787452439232;6078;5916.23088998436;5982.4017598239825;6013;6040.365761595057;6122.062734707273;5938.732757025944;6063.9090413643835;6096.420840020191;6102.633841969496;6104.38956104386;5867.589268751231;6097.634141951497;6140.048292514667;6141.570090093651;6148.8770224595255;4579.244424669892;4592.88517787058;4594.471635761864;4594.95405045952;4597.195490789099;4050.9189816204102;4108.055147316074;4110.938335924963;4111.6299533042165;4112.09533902541;5698.430156984268;5747.971260143672;5759.107338362561;5760.6255593386295;5765.250517432707;6074.848128796727;6095.420935011167;6098.817035488943;6099.969500152471;6110.572259941761;5561.110222364402;5663.377028526858;5699.572532060112;5769.884602308014;5790.652560846363;5233.241180028875;5233.921491177635;5281.577473802086;5288.2596436498925;5298.09932311508;6079.544034197453;6301.212348456443;6336.271328797156;6340.365963403715;6340.809775706736;5913.556483263773;6062.393760623902;6151.753929842756;6153.753849846135;6155.47678447337;6363.904541431974;6389.105525226565;6389.584676995981;6393.392627700361;6396.296407395276;5819.5635327351465;6015.2781666200335;6154.230721159855;6174.969125154345;6182.629042257479;6057.091436284416;6142.447179753844;6144.047672610753;6148.3236843948025;6150.384961503813;5984;5997.790077347272;6001.06983417571;6006.909896351645;6007.249093863267;5673.375928647928;5791.565632577489;5898.616589921641;6010.519158467225;6013.067974463965;5861.794837180678;5868.38381969887;5877.853053673693;5879.911801323069;5894.351621321737;5924.200232968494;5943.524518038633;5974.820755377345;5975.312839023568;5977.7310021050025;5586.13414920688;5684.545236381162;5771.336296325976;5824.737886795019;5881.117832325185 13:25:48 INFO - 2015-12-28 13:25:48,598 DEBUG : BROWSER_OUTPUT: |1;ext.html;602.7046747093923;633.0346222011432;640.260499123512;640.3628389752197;645.0839807473386;42592.36111458327;43652.345214821806;43698;43700.56299437005;43715.344269835936;46286.76856615712;46885;46936.295955560694;46967.530324696745;46972;8198.38512111591;8316.625751841182;9142.999999999984;9305.581248843784;10396.11633011195;10698.572057117706;10717.785644287149;10830.350178989247;10840.186985976045;10852.891471085268;10688.78622427555;10699.518521666505;10821.621243256488;10850.403227822466;10854.185936054788;10733.570657173703;10837.729056773565;10840.512176952056;10846.240763146505;10857.891421085767;10598.947005265001;10784.514696838583;10791.298565593212;10793.5682572697;10842.512086956105;43234.78382608067;43546.346804797955;43616.12767744659;43686.56313436857;43801.12397752027;3661.212839239576;3721.4603882436895;4036.6770658347264;4296.9570304297185;4299.355096735515;33305.66694333074;33341;33365.16587085318;33395.332093357996;33637.83181084079;3355.4799006154085;3400.1669590950128;3408.4442358954743;3425.811580363079;3535.1515636247373;328113;328365;330210;330319;330550;56752.43247567554;57506.42493575011;63753.68123159447;64243;69099.30900691029;66086;66293;66937.33062669408;66942.66528667326;66954;18048.09759512019;18051.54871128206;18240;18298.359557415428;18309.267629294678;12606.55877044299;12786.808197877039;12794.744105117845;12803.679908002188;12829.23024618526;20547.8972605136;20836.583268334547;20933.79066209349;20964.895175524023;20996.685049724267;7945.602719863984;8159.67361305553;8172.915906443819;8178.427510074357;8185.4270201085355;986.5954958466995;991.7768502086973;1012.4937531234383;1086.1907878630313;1134.2910680824484;29177.7082229175;29658.55512167319;29737;30387.544186837215;31016.379672406427;1109.9056580190775;1129.728865072393;1208.2871106047473;1212.7811549392804;1223.559518573313;13213.867861321263;14693.485727999469;14825.851741482662;15039.172845493384;15699.450519231772;293489;294737;295503;296197;296334;50452.747736261816;50813;50857.74571127121;50906.236406453936;51071;1494.2080697230485;1496.102338596855;1497.4160077569757;1505.7289687856291;1506.6308754355252;27859.72140278571;28975.85512072426;29650.851745741133;29780.55329170021;29843.701562984093;46674.29988550243;47861.04277914353;48719.26921096257;52711.20933185929;53787.462125378246;250251;250449;250916;251413;251468;33460.163495911824;33739.3252134951;33804.83097584496;33858.15354616154;33892.49161262633;46277.30584041309;46950.53049469461;47106.76446617745;47259.291110634054;47596;38729.41905871358;38772.224555509296;38822.6117738819;38955.61044389633;40170.39744403778;38893.416598750475;40094;40586.391204131374;40705;41246;37405.251894962494;38184.23631527298;38243.42634860535;38425.80787096047;38475.615243847205;34155.31689366149;34833.30333393368;35071.123221918635;35322.64677353194;37174.07064823401;25538.872305638353;26081.217563473125;26108.8694556526;26337.20988370352;28251.858740706986 13:25:48 INFO - 2015-12-28 13:25:48,599 DEBUG : BROWSER_OUTPUT: |2;jquery.html;388.6657474571868;391.3992022245852;394.3867286369694;395.39701954519353;399.3909288335287;12813.871861281385;15712.114546254437;17825.197866096023;18708.719369209473;18736.156872940734;13713.862861371383;14006.579802605938;14007.719845603082;20197.99010049499;20699.896500517512;4922.163232250508;5030.723310217936;5036.471170527097;5039.19372900336;5039.44566097729;3975.244703506339;4035.273650742865;4968.453470118284;5400.83797486076;5544.86137846553;5443.455654434545;5470;5471.37079235887;5485.149801780711;5490.972545137269;5306.946930530684;5354.437784032699;5354.759035843396;5372.435894231108;5376.91934620981;4631.976840115812;4639.86080417588;4641.76791160444;4652.185867473178;4662.8134874604975;15590.844091559053;16026.118563479004;16125.43560975372;16164.191790410432;16173.867829251956;2293.243229734184;2298.2990187992655;2320.1183550250967;2326.441654003044;2491.9750802491926;11034.337939723562;11188.608398706006;11303.943480282629;11348.886511134866;11533.884661153365;1830.057520377007;1859.2098358197848;1908.4656296237076;1924.8845069295887;1973.1416833677397;67685.3231467684;67780;68102.3189768106;69077.65461172712;69265.3073469269;7641.3886889048745;7651.464397492122;7757.72847950319;7848.13670496245;7856.764297070983;9502.097300756417;9533.380330278509;9543.618255269712;9546.140847323773;9549.570269337897;6156.415140561639;6267.185265915402;6285.96857015712;6298.338674439209;6300.117983482316;6208;6253.6873156342;6260;6281.434670879643;6322.778702745474;3549.591796943333;3609.657082577151;3624.6919011884283;3626.111602657366;3628.1473853644375;1214.684182112657;1240.1690867119053;1273.4269578689627;1313.4811749359142;1321.0356439799;457.5584560898749;464.1992562829093;472.8652334084769;493.64457590534755;513.7251570409812;10283.331583447052;11373.658790236306;12213.145079844504;12288.692782680326;12313.56902508408;488.5749398023671;496.63249195595;497.9502049794992;513.4659953648164;522.146290814521;5431.565474762009;6500.057491663682;6702.83242918931;6708.262091169968;6790.7623233186605;608693;624083;631912;633994;647884;84558.57720711357;85216;86182.56908715416;86361.13638863657;88014.55992719995;530.8301343570098;533.4105813076573;533.6104643610108;534.2360424592791;534.2573822386885;11410.486528106088;11539.07687385024;11552.6534203974;11595.072394208275;11644.5342186315;38907.02732431712;39202.01994950149;39210.2157956845;40527.1894562113;40735.38896916608;52154.73922630362;53112;53214.73392633012;53858.46141538535;54785.17822232749;7717.421193410629;7763.301302882542;7833.529988200727;7924.920750792418;7942.324902383131;13683.315834208448;14058.718825623635;14194.148351098967;14227.50203742864;14322.069065511125;12124.939375303067;12127;12228.510859565518;12269.509219631473;12321.199122057038;11628.360440175533;11930.343831089373;12121.939390302992;12296.139270250997;12443.93778031104;10277.280590358901;10722.356658600196;11918.165728398928;12099.879001210227;12146.453409596767;7782.260685234894;7923.20767923203;14971.176585287914;15143.545693629208;17587.208575614382;10856.565737370733;11165.888341116484;11237.7752444949;11274.718132046764;17309.65380692404 13:25:48 INFO - 2015-12-28 13:25:48,602 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1553.1612929018331;1555.9844401555988;1807.6203997160596;1819.5087326421865;1848.5009047557155;7031;7179.425645948325;7957.323627491663;8100.068492123408;8100.149484304145;7573.0912290525075;7690.077190737119;7766.339861111798;7779.805504862381;7780.961095194516;2375.7030371203555;2412.843165194257;2413.5414271288487;2414.9758502415016;2416.6254230594286;2029.391182645208;2128.9148434062618;2326.1858349577683;2377.0135393811547;2411.131992482705;2271.636538153896;2284.7372552156467;2290.9083636654514;2295.116380193629;2301.42464383904;2295.345826439465;2319.976800231993;2320.8259380546356;2320.8859747321294;2320.9883950580306;2361.114582031738;2424.6120620700603;2426.8422552534207;2427.987860060706;2428.963565546518;7976.601169941479;8034.598270086531;8038.959805200995;8049.517028978222;8050.235227653364;4839.395075615548;4892.9510704892855;4904.068227036852;4904.068227036852;4906.165951788169;3238.8380580970856;3309.5035744638258;3358.0261724099983;3369.2756057447523;3372.1401042733946;998.2513115163628;999.4353190447447;1005.3113617172187;1032.9845052324222;1033.5400746667735;10596;10602.787944241149;10607.628732994308;10615.09771669409;10644.467776611216;4525.818967241339;4534.13851368239;4606.907861842811;4625.514320996314;4676.415448068991;9216.216621587106;9242.260619150451;9242.537873106452;9254.907450925404;9266.907330926604;5010.674306170087;5012.24816277554;5013.548780609763;5018.799248030111;5023.472535383805;4584;4591.540845915449;4593.885152871205;4594.1271158479785;4606.677532572688;3866.168773713665;3917.804109794499;3920.4315374270573;3945.980270098631;3955.7626542407547;1137.3005601555149;1177.140687298277;1244.1912756708211;1301.4208677138772;1303.1594621469098;1145.2040831621944;1145.3414286785132;1185.2829038431626;1199.5082016373244;1222.2727477151082;7459.104907411145;7508.549487030796;7519.924800752032;7558.13081495624;7768.689252429839;1198.2271434924426;1200.0939290835538;1207.7644859252362;1218.9268643881396;1222.7554489102215;5851.327097383855;5921.526277897758;5929.407059294036;5932.911006334908;5934.762609495572;9327.533623318806;9735.075167859042;9754.219662426989;9754.951225243829;9771.022897710172;9665.855012174823;9681.467519286365;9686.370385924893;9698.418094914186;9698.6120555177;7381.261873812683;7431.29402706742;7462.179160292363;7470.626468676544;7569.621518924032;7159.355657990805;7185.317394847481;7190.06529151207;7242.239564845615;7255.637218139177;8356.6239519223;8591.613377397907;8593.097724738813;8603.053664096818;8606.956965215133;8649.394542381973;8660.566971651266;8720.258778003687;8720.607572659119;8742.12578742146;7032.929670703227;7076.540024898365;7077.256888026683;7078.1860086090755;7086.822829429306;6940.687669054803;7830.657167694186;7882.5270483771155;7886.329661978796;7886.526808391515;7212.819679508054;7314.34170924598;7323.267673232847;7326.377257933135;7431.702731890664;7233.0597022386755;7269.818254543678;7316.195218526064;7367.926320736939;7381.298776616213;7427.8143046424275;7457.142428620561;7460.253974602496;7461.4403919705155;7462.888056679263;6659.633720145439;6711.328867113445;6780.288069752803;6809.455243580601;6819.386255237053;6825.965870170618;6846.657667116724;6852.451803855779;6865.897011544731;6877.518573699993 13:25:48 INFO - 2015-12-28 13:25:48,604 DEBUG : BROWSER_OUTPUT: |4;prototype.html;366.8422578291335;371.32048351516727;372.3260897775027;376.40527965814016;382.6670796407128;5914.733836977335;5921.230240068796;5974;5979.461848433634;6011.188489553909;5816.476517113459;5912.467877890989;5918.201042859213;5945.286565612122;5969.373215812342;4674.205385084527;4680.4149481314835;4686.9296960545535;4687.086018226447;4691.741954192518;4684.391029166203;4687.086018226447;4687.132880417117;4690.882727931795;4692.882677933062;4568.908621827562;4659.4175728034;4669.649776266793;4726.598239149676;4736.3842700448895;4699.95300047002;4703.247480403136;4706.176419126657;4722.244440889458;4723.4568024677255;3978.880633580968;4205.894852628709;4206.3690446432975;4213.988642725754;4217.367394890791;5558.888822223533;5601.047821870292;5648.350439699405;5652.3217213934595;5666.235058267122;5406.189071639246;5413.188021796723;5428.701421421821;5429.53848922842;5431.131019036935;6318.957372033609;6325.304216536178;6326.810195694136;6328.050792381134;6328.7468501260355;4523.321501774727;4612.238980568202;4616;4619.260918253063;4626.097910907374;6471.741130354781;6477.54657173998;6478.222613286389;6484.967575162094;6487.351264873475;4730.195866702668;4736.289556566542;4736.64475164364;4737.147313483606;4741.454732705714;4747.0505898820375;4794;4796.352492413549;4803.663743537919;4803.927941080887;5498.092814685612;5508.834734957958;5512.145617429305;5518.19986102021;5518.779248830002;6439.613623182624;6452.419282264619;6458.031295305742;6458.451031662267;6458.838529036811;1727.5076603168036;1727.6544691061838;1727.7926648802224;1727.9891263610928;1728.438257566296;1208.8609809871978;1210.7396909664465;1213.878612138779;1214.4474264209764;1240.3178251961385;6222.439980401786;6225.159603453566;6226.40849119333;6227.595206311576;6231.3145553989025;6632.237292711304;6636;6636.30318816527;6636.701348439332;6639.933600664028;6140.692965351804;6214.1921550198185;6216.160818289473;6218.440340369389;6220.409061139185;3634.890953271406;3671.7429779915683;3672.889813305605;3673.44898265257;3673.577538583044;6606.7026983785845;6687.933120668828;6751.527393082437;6852.109225800614;6911.205211400653;6766.25571187169;6776.728930842711;6785.42323902464;6788.932110678928;6805.863882722318;6801.591904485746;6804.285550017276;6806.829829254309;6812.659367031629;6815.727370905208;6465.838354040999;6595.967020164869;6606.273309935807;6608.900866487103;6613.900791488228;6610.4050635443045;6622.07290979273;6627.304133065959;6630.867382652416;6637.70130344126;6799.11611490503;6800.727970881109;6803.25164231944;6813.89779153323;6815.182178138457;4628.930566041579;4714.057188562233;4716.268978308368;4716.33971244033;4716.905661886812;6604.636744979072;6611.041398997215;6612.074309596756;6615.768448104293;6616.305287944697;6437.645929473924;6453.806385808433;6455.48356131499;6458.031295305742;6463.547551671526;6340.1123842661145;6411.903821442589;6427.967860160669;6440.420362167428;6444.065610486547;6337.017762246859;6340.714667839866;6342.809715708536;6343.11196432509;6348;6382.680865956777;6471.288158302489;6476.255230648348;6476.676166191766;6479.546431749733;6254.8123556293385;6256.749730010749;6262;6263.154474145932;6263.185785847811 13:25:48 INFO - 2015-12-28 13:25:48,605 DEBUG : BROWSER_OUTPUT: |5;yui.html;834.8330333933214;873.3362644390265;907.6596276396353;932.1051790281331;934.6635211323922;14634;14957.850421495808;14980.550583482485;14982;14994.775078373834;14283.571492855204;14343.497977570787;14368.568942931728;14393.06445081069;14393.64015899603;773.2692605487816;791.8970533830623;915.4370062411635;935.3125452792192;936.9906300937006;926.5691453474133;926.9073092690711;932;938.3947353956694;938.7465384346223;817.9672813087469;968.5157421289356;977.7897751983322;977.9022097790199;980.8675828763132;823.1768231768202;960.8894977077621;969.7914948286152;970.3450171134491;970.5389939778619;719.4855678190119;723.2803360656128;724.2901956083068;724.90213821134;725.5537844225815;14960.70078598422;15059.774103388349;15073.623159420993;15084.472043478425;15085.773713394308;13233.470661173542;13788.586342409744;14376.856231437761;14458.421663133462;14498.057626254365;11047.72380690481;11348.09215262777;11432.37121958292;11439.19925605208;11445.198836081478;3738.065483629093;3763.9811800941093;3784.5836957934607;3809.8095095245126;3850.6726928211137;52098.47901520974;52214;54128.72935635336;54239.186412204246;54392.728036359964;10390.324628899098;10459.320144190604;10482.423466709251;10700.785984280426;10910.945445272722;20328.898355508423;20380.18479260813;20395.59208815845;20404.591908161754;20414.79585204129;7839.6472158752995;8025;8152.673893044212;8177.509349439053;8353.540555269397;4637.072585482917;4722.740249286322;4777.546133117348;4832.516748325139;4960.057589058068;3310.2882880180396;3340.9498857517156;3344.4983252512316;3347.6484969078383;3357.9496307555405;481.08113503208705;498.39942868842957;509.36075225591645;513.1071934833437;519.8128673677473;553.1143715399272;643.340575909687;646.7194953991124;669.1835960128635;676.6549059979446;8939.597718102701;8945.642174312954;9378.812423751488;9400.717978460658;9746.512674366253;602.8251806975928;668.3350066683681;707.5507053021369;714.1679942866606;736.7716008037526;4126.711130220916;4215.641670457984;4330.848420305274;4378.562143785596;4402.625776809007;66163.33836661668;66560;67262;67377.32622673809;67400.32599674039;58883.70558147182;59610.70194648999;59995;60096.699516502136;61057.389426106056;54028.18957715637;54120;54936.725316373166;55571.72214138904;55624.16563751547;7932.762017139495;8495.74512764618;8541.05916658822;8731.825363492568;8812.074732153287;39250;39824.2035159301;40083;40239;40242.1951560973;49737.502624973284;52272.738636306574;52597.47402526079;53090.46909530855;53363.733181333846;8290.08809030994;8322.6670933162;8371.121032291521;8458.703945361884;8601.311895048257;10969;10972.561097556008;10991.175661825235;11104.944475277573;11180.832287515856;11110.666679999289;11184;11280.435978200892;11321.207515473838;11398.886011139783;11528.308301501937;11616.573110932126;11704.648860533856;12019.399030048287;12212.694682633006;10620.022019659275;10819.891801081889;10938.179636527133;10970.561177552809;11020.063294619726;10047.899521004696;10657.467126643482;10802.513886874953;10821.945890270814;10963.671089867317;9893.35693179941;9982.700518984442;10002.699919002442;10084;10124.949375253076 13:25:48 INFO - 2015-12-28 13:25:48,605 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:25:48 INFO - 2015-12-28 13:25:48,605 DEBUG : BROWSER_OUTPUT: __start_cc_report 13:25:48 INFO - 2015-12-28 13:25:48,605 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,811 13:25:48 INFO - 2015-12-28 13:25:48,605 DEBUG : BROWSER_OUTPUT: __end_cc_report 13:25:48 INFO - 2015-12-28 13:25:48,605 DEBUG : BROWSER_OUTPUT: __startTimestamp1451337948592__endTimestamp 13:25:48 INFO - 2015-12-28 13:25:48,605 DEBUG : BROWSER_OUTPUT: 13:25:48 INFO - 2015-12-28 13:25:48,605 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:25:48 INFO - 2015-12-28 13:25:48,606 DEBUG : BROWSER_OUTPUT: Number of tests: 6 13:25:48 INFO - 2015-12-28 13:25:48,606 DEBUG : BROWSER_OUTPUT: 13:25:48 INFO - 2015-12-28 13:25:48,606 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5632.23 Median:5861.79 stddev:642.63 (11.0%) stddev-sans-first:618.97 13:25:48 INFO - 2015-12-28 13:25:48,606 DEBUG : BROWSER_OUTPUT: Values: 3341.6 3397.3 3420.1 3424.9 3453.7 5577.9 5607.6 5614.3 5617.3 5617.8 5601.1 5660.9 5666.5 5672.2 5672.2 4970.7 5130.8 5150.1 5176.5 5192.5 5131.7 5136.8 5153.6 5157.3 5159.9 5078.5 5100.3 5151.5 5151.9 5161.3 5094.9 5131.6 5254.3 5260.3 5262.8 5118.5 5147.7 5166.0 5189.3 5191.3 5245.8 5254.1 5349.8 5451.6 5452.6 6064.4 6073.0 6079.3 6090.4 6099.2 6085.2 6091.3 6093.9 6097.3 6122.7 5478.4 5557.6 5584.8 5703.2 5712.1 6010.5 6199.7 6201.8 6209.8 6211.1 6027.2 6063.2 6065.5 6072.8 6078.0 5916.2 5982.4 6013.0 6040.4 6122.1 5938.7 6063.9 6096.4 6102.6 6104.4 5867.6 6097.6 6140.0 6141.6 6148.9 4579.2 4592.9 4594.5 4595.0 4597.2 4050.9 4108.1 4110.9 4111.6 4112.1 5698.4 5748.0 5759.1 5760.6 5765.3 6074.8 6095.4 6098.8 6100.0 6110.6 5561.1 5663.4 5699.6 5769.9 5790.7 5233.2 5233.9 5281.6 5288.3 5298.1 6079.5 6301.2 6336.3 6340.4 6340.8 5913.6 6062.4 6151.8 6153.8 6155.5 6363.9 6389.1 6389.6 6393.4 6396.3 5819.6 6015.3 6154.2 6175.0 6182.6 6057.1 6142.4 6144.0 6148.3 6150.4 5984.0 5997.8 6001.1 6006.9 6007.2 5673.4 5791.6 5898.6 6010.5 6013.1 5861.8 5868.4 5877.9 5879.9 5894.4 5924.2 5943.5 5974.8 5975.3 5977.7 5586.1 5684.5 5771.3 5824.7 5881.1 13:25:48 INFO - 2015-12-28 13:25:48,606 DEBUG : BROWSER_OUTPUT: 13:25:48 INFO - 2015-12-28 13:25:48,606 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:48071.61 Median:33688.58 stddev:76496.68 (227.1%) stddev-sans-first:76628.24 13:25:48 INFO - 2015-12-28 13:25:48,607 DEBUG : BROWSER_OUTPUT: Values: 602.7 633.0 640.3 640.4 645.1 42592.4 43652.3 43698.0 43700.6 43715.3 46286.8 46885.0 46936.3 46967.5 46972.0 8198.4 8316.6 9143.0 9305.6 10396.1 10698.6 10717.8 10830.4 10840.2 10852.9 10688.8 10699.5 10821.6 10850.4 10854.2 10733.6 10837.7 10840.5 10846.2 10857.9 10598.9 10784.5 10791.3 10793.6 10842.5 43234.8 43546.3 43616.1 43686.6 43801.1 3661.2 3721.5 4036.7 4297.0 4299.4 33305.7 33341.0 33365.2 33395.3 33637.8 3355.5 3400.2 3408.4 3425.8 3535.2 328113.0 328365.0 330210.0 330319.0 330550.0 56752.4 57506.4 63753.7 64243.0 69099.3 66086.0 66293.0 66937.3 66942.7 66954.0 18048.1 18051.5 18240.0 18298.4 18309.3 12606.6 12786.8 12794.7 12803.7 12829.2 20547.9 20836.6 20933.8 20964.9 20996.7 7945.6 8159.7 8172.9 8178.4 8185.4 986.6 991.8 1012.5 1086.2 1134.3 29177.7 29658.6 29737.0 30387.5 31016.4 1109.9 1129.7 1208.3 1212.8 1223.6 13213.9 14693.5 14825.9 15039.2 15699.5 293489.0 294737.0 295503.0 296197.0 296334.0 50452.7 50813.0 50857.7 50906.2 51071.0 1494.2 1496.1 1497.4 1505.7 1506.6 27859.7 28975.9 29650.9 29780.6 29843.7 46674.3 47861.0 48719.3 52711.2 53787.5 250251.0 250449.0 250916.0 251413.0 251468.0 33460.2 33739.3 33804.8 33858.2 33892.5 46277.3 46950.5 47106.8 47259.3 47596.0 38729.4 38772.2 38822.6 38955.6 40170.4 38893.4 40094.0 40586.4 40705.0 41246.0 37405.3 38184.2 38243.4 38425.8 38475.6 34155.3 34833.3 35071.1 35322.6 37174.1 25538.9 26081.2 26108.9 26337.2 28251.9 13:25:48 INFO - 2015-12-28 13:25:48,607 DEBUG : BROWSER_OUTPUT: 13:25:48 INFO - 2015-12-28 13:25:48,607 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:30999.70 Median:2544.77 stddev:103134.51 (4052.8%) stddev-sans-first:103398.21 13:25:48 INFO - 2015-12-28 13:25:48,608 DEBUG : BROWSER_OUTPUT: Values: 388.7 391.4 394.4 395.4 399.4 12813.9 15712.1 17825.2 18708.7 18736.2 13713.9 14006.6 14007.7 20198.0 20699.9 4922.2 5030.7 5036.5 5039.2 5039.4 3975.2 4035.3 4968.5 5400.8 5544.9 5443.5 5470.0 5471.4 5485.1 5491.0 5306.9 5354.4 5354.8 5372.4 5376.9 4632.0 4639.9 4641.8 4652.2 4662.8 15590.8 16026.1 16125.4 16164.2 16173.9 2293.2 2298.3 2320.1 2326.4 2492.0 11034.3 11188.6 11303.9 11348.9 11533.9 1830.1 1859.2 1908.5 1924.9 1973.1 67685.3 67780.0 68102.3 69077.7 69265.3 7641.4 7651.5 7757.7 7848.1 7856.8 9502.1 9533.4 9543.6 9546.1 9549.6 6156.4 6267.2 6286.0 6298.3 6300.1 6208.0 6253.7 6260.0 6281.4 6322.8 3549.6 3609.7 3624.7 3626.1 3628.1 1214.7 1240.2 1273.4 1313.5 1321.0 457.6 464.2 472.9 493.6 513.7 10283.3 11373.7 12213.1 12288.7 12313.6 488.6 496.6 498.0 513.5 522.1 5431.6 6500.1 6702.8 6708.3 6790.8 608693.0 624083.0 631912.0 633994.0 647884.0 84558.6 85216.0 86182.6 86361.1 88014.6 530.8 533.4 533.6 534.2 534.3 11410.5 11539.1 11552.7 11595.1 11644.5 38907.0 39202.0 39210.2 40527.2 40735.4 52154.7 53112.0 53214.7 53858.5 54785.2 7717.4 7763.3 7833.5 7924.9 7942.3 13683.3 14058.7 14194.1 14227.5 14322.1 12124.9 12127.0 12228.5 12269.5 12321.2 11628.4 11930.3 12121.9 12296.1 12443.9 10277.3 10722.4 11918.2 12099.9 12146.5 7782.3 7923.2 14971.2 15143.5 17587.2 10856.6 11165.9 11237.8 11274.7 17309.7 13:25:48 INFO - 2015-12-28 13:25:48,608 DEBUG : BROWSER_OUTPUT: 13:25:48 INFO - 2015-12-28 13:25:48,608 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5634.99 Median:6794.87 stddev:2855.97 (42.0%) stddev-sans-first:2847.50 13:25:48 INFO - 2015-12-28 13:25:48,609 DEBUG : BROWSER_OUTPUT: Values: 1553.2 1556.0 1807.6 1819.5 1848.5 7031.0 7179.4 7957.3 8100.1 8100.1 7573.1 7690.1 7766.3 7779.8 7781.0 2375.7 2412.8 2413.5 2415.0 2416.6 2029.4 2128.9 2326.2 2377.0 2411.1 2271.6 2284.7 2290.9 2295.1 2301.4 2295.3 2320.0 2320.8 2320.9 2321.0 2361.1 2424.6 2426.8 2428.0 2429.0 7976.6 8034.6 8039.0 8049.5 8050.2 4839.4 4893.0 4904.1 4904.1 4906.2 3238.8 3309.5 3358.0 3369.3 3372.1 998.3 999.4 1005.3 1033.0 1033.5 10596.0 10602.8 10607.6 10615.1 10644.5 4525.8 4534.1 4606.9 4625.5 4676.4 9216.2 9242.3 9242.5 9254.9 9266.9 5010.7 5012.2 5013.5 5018.8 5023.5 4584.0 4591.5 4593.9 4594.1 4606.7 3866.2 3917.8 3920.4 3946.0 3955.8 1137.3 1177.1 1244.2 1301.4 1303.2 1145.2 1145.3 1185.3 1199.5 1222.3 7459.1 7508.5 7519.9 7558.1 7768.7 1198.2 1200.1 1207.8 1218.9 1222.8 5851.3 5921.5 5929.4 5932.9 5934.8 9327.5 9735.1 9754.2 9755.0 9771.0 9665.9 9681.5 9686.4 9698.4 9698.6 7381.3 7431.3 7462.2 7470.6 7569.6 7159.4 7185.3 7190.1 7242.2 7255.6 8356.6 8591.6 8593.1 8603.1 8607.0 8649.4 8660.6 8720.3 8720.6 8742.1 7032.9 7076.5 7077.3 7078.2 7086.8 6940.7 7830.7 7882.5 7886.3 7886.5 7212.8 7314.3 7323.3 7326.4 7431.7 7233.1 7269.8 7316.2 7367.9 7381.3 7427.8 7457.1 7460.3 7461.4 7462.9 6659.6 6711.3 6780.3 6809.5 6819.4 6826.0 6846.7 6852.5 6865.9 6877.5 13:25:48 INFO - 2015-12-28 13:25:48,609 DEBUG : BROWSER_OUTPUT: 13:25:48 INFO - 2015-12-28 13:25:48,609 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5399.61 Median:6177.44 stddev:1571.27 (25.4%) stddev-sans-first:1529.60 13:25:48 INFO - 2015-12-28 13:25:48,609 DEBUG : BROWSER_OUTPUT: Values: 366.8 371.3 372.3 376.4 382.7 5914.7 5921.2 5974.0 5979.5 6011.2 5816.5 5912.5 5918.2 5945.3 5969.4 4674.2 4680.4 4686.9 4687.1 4691.7 4684.4 4687.1 4687.1 4690.9 4692.9 4568.9 4659.4 4669.6 4726.6 4736.4 4700.0 4703.2 4706.2 4722.2 4723.5 3978.9 4205.9 4206.4 4214.0 4217.4 5558.9 5601.0 5648.4 5652.3 5666.2 5406.2 5413.2 5428.7 5429.5 5431.1 6319.0 6325.3 6326.8 6328.1 6328.7 4523.3 4612.2 4616.0 4619.3 4626.1 6471.7 6477.5 6478.2 6485.0 6487.4 4730.2 4736.3 4736.6 4737.1 4741.5 4747.1 4794.0 4796.4 4803.7 4803.9 5498.1 5508.8 5512.1 5518.2 5518.8 6439.6 6452.4 6458.0 6458.5 6458.8 1727.5 1727.7 1727.8 1728.0 1728.4 1208.9 1210.7 1213.9 1214.4 1240.3 6222.4 6225.2 6226.4 6227.6 6231.3 6632.2 6636.0 6636.3 6636.7 6639.9 6140.7 6214.2 6216.2 6218.4 6220.4 3634.9 3671.7 3672.9 3673.4 3673.6 6606.7 6687.9 6751.5 6852.1 6911.2 6766.3 6776.7 6785.4 6788.9 6805.9 6801.6 6804.3 6806.8 6812.7 6815.7 6465.8 6596.0 6606.3 6608.9 6613.9 6610.4 6622.1 6627.3 6630.9 6637.7 6799.1 6800.7 6803.3 6813.9 6815.2 4628.9 4714.1 4716.3 4716.3 4716.9 6604.6 6611.0 6612.1 6615.8 6616.3 6437.6 6453.8 6455.5 6458.0 6463.5 6340.1 6411.9 6428.0 6440.4 6444.1 6337.0 6340.7 6342.8 6343.1 6348.0 6382.7 6471.3 6476.3 6476.7 6479.5 6254.8 6256.7 6262.0 6263.2 6263.2 13:25:48 INFO - 2015-12-28 13:25:48,610 DEBUG : BROWSER_OUTPUT: 13:25:48 INFO - 2015-12-28 13:25:48,610 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:15314.23 Median:503.88 stddev:18623.17 (3696.0%) stddev-sans-first:18643.67 13:25:48 INFO - 2015-12-28 13:25:48,611 DEBUG : BROWSER_OUTPUT: Values: 834.8 873.3 907.7 932.1 934.7 14634.0 14957.9 14980.6 14982.0 14994.8 14283.6 14343.5 14368.6 14393.1 14393.6 773.3 791.9 915.4 935.3 937.0 926.6 926.9 932.0 938.4 938.7 818.0 968.5 977.8 977.9 980.9 823.2 960.9 969.8 970.3 970.5 719.5 723.3 724.3 724.9 725.6 14960.7 15059.8 15073.6 15084.5 15085.8 13233.5 13788.6 14376.9 14458.4 14498.1 11047.7 11348.1 11432.4 11439.2 11445.2 3738.1 3764.0 3784.6 3809.8 3850.7 52098.5 52214.0 54128.7 54239.2 54392.7 10390.3 10459.3 10482.4 10700.8 10910.9 20328.9 20380.2 20395.6 20404.6 20414.8 7839.6 8025.0 8152.7 8177.5 8353.5 4637.1 4722.7 4777.5 4832.5 4960.1 3310.3 3340.9 3344.5 3347.6 3357.9 481.1 498.4 509.4 513.1 519.8 553.1 643.3 646.7 669.2 676.7 8939.6 8945.6 9378.8 9400.7 9746.5 602.8 668.3 707.6 714.2 736.8 4126.7 4215.6 4330.8 4378.6 4402.6 66163.3 66560.0 67262.0 67377.3 67400.3 58883.7 59610.7 59995.0 60096.7 61057.4 54028.2 54120.0 54936.7 55571.7 55624.2 7932.8 8495.7 8541.1 8731.8 8812.1 39250.0 39824.2 40083.0 40239.0 40242.2 49737.5 52272.7 52597.5 53090.5 53363.7 8290.1 8322.7 8371.1 8458.7 8601.3 10969.0 10972.6 10991.2 11104.9 11180.8 11110.7 11184.0 11280.4 11321.2 11398.9 11528.3 11616.6 11704.6 12019.4 12212.7 10620.0 10819.9 10938.2 10970.6 11020.1 10047.9 10657.5 10802.5 10821.9 10963.7 9893.4 9982.7 10002.7 10084.0 10124.9 13:25:48 INFO - 2015-12-28 13:25:48,611 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:25:48 INFO - 2015-12-28 13:25:48,611 DEBUG : BROWSER_OUTPUT: 13:25:49 INFO - 2015-12-28 13:25:49,041 INFO : Browser exited with error code: 0 13:25:49 INFO - 2015-12-28 13:25:49,064 INFO : Completed test dromaeo_css (00:18:29) 13:25:49 INFO - 2015-12-28 13:25:49,065 INFO : Starting test kraken 13:25:49 INFO - 2015-12-28 13:25:49,065 DEBUG : operating with platform_type : linux_ 13:25:49 INFO - 2015-12-28 13:25:49,065 INFO : Initialising browser for kraken test... 13:25:49 INFO - 2015-12-28 13:25:49,071 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpqcv1RZ/profile http://localhost:58079/getInfo.html 13:25:52 INFO - 2015-12-28 13:25:52,536 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:25:52 INFO - 2015-12-28 13:25:52,536 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:25:52 INFO - 2015-12-28 13:25:52,536 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 13:25:52 INFO - 2015-12-28 13:25:52,536 DEBUG : BROWSER_OUTPUT: __metrics 13:25:52 INFO - 2015-12-28 13:25:52,625 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] 13:25:53 INFO - 2015-12-28 13:25:53,937 INFO : Browser initialized. 13:25:53 INFO - 2015-12-28 13:25:53,937 INFO : Running cycle 1/1 for kraken test... 13:25:53 INFO - 2015-12-28 13:25:53,938 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpqcv1RZ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:26:05 INFO - 2015-12-28 13:26:05,526 DEBUG : BROWSER_OUTPUT: RSS: Main: 129069056 13:26:05 INFO - 2015-12-28 13:26:05,526 DEBUG : BROWSER_OUTPUT: 13:26:07 INFO - 2015-12-28 13:26:07,941 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58079/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58079/tests/kraken/driver.html?testName=audio-beat-detection) 13:26:08 INFO - 2015-12-28 13:26:08,508 DEBUG : BROWSER_OUTPUT: RSS: Main: 164294656 13:26:08 INFO - 2015-12-28 13:26:08,509 DEBUG : BROWSER_OUTPUT: 13:26:11 INFO - 2015-12-28 13:26:11,058 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58079/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58079/tests/kraken/driver.html?testName=audio-dft) 13:26:11 INFO - 2015-12-28 13:26:11,624 DEBUG : BROWSER_OUTPUT: RSS: Main: 161185792 13:26:11 INFO - 2015-12-28 13:26:11,624 DEBUG : BROWSER_OUTPUT: 13:26:14 INFO - 2015-12-28 13:26:14,408 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58079/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58079/tests/kraken/driver.html?testName=audio-fft) 13:26:14 INFO - 2015-12-28 13:26:14,971 DEBUG : BROWSER_OUTPUT: RSS: Main: 157732864 13:26:14 INFO - 2015-12-28 13:26:14,972 DEBUG : BROWSER_OUTPUT: 13:26:16 INFO - 2015-12-28 13:26:16,935 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58079/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58079/tests/kraken/driver.html?testName=audio-oscillator) 13:26:17 INFO - 2015-12-28 13:26:17,496 DEBUG : BROWSER_OUTPUT: RSS: Main: 157839360 13:26:17 INFO - 2015-12-28 13:26:17,497 DEBUG : BROWSER_OUTPUT: 13:26:19 INFO - 2015-12-28 13:26:19,611 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58079/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58079/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:26:20 INFO - 2015-12-28 13:26:20,174 DEBUG : BROWSER_OUTPUT: RSS: Main: 155734016 13:26:20 INFO - 2015-12-28 13:26:20,174 DEBUG : BROWSER_OUTPUT: 13:26:23 INFO - 2015-12-28 13:26:23,021 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58079/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58079/tests/kraken/driver.html?testName=imaging-darkroom) 13:26:23 INFO - 2015-12-28 13:26:23,588 DEBUG : BROWSER_OUTPUT: RSS: Main: 155750400 13:26:23 INFO - 2015-12-28 13:26:23,589 DEBUG : BROWSER_OUTPUT: 13:26:26 INFO - 2015-12-28 13:26:26,912 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58079/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58079/tests/kraken/driver.html?testName=imaging-desaturate) 13:26:27 INFO - 2015-12-28 13:26:27,479 DEBUG : BROWSER_OUTPUT: RSS: Main: 157454336 13:26:27 INFO - 2015-12-28 13:26:27,479 DEBUG : BROWSER_OUTPUT: 13:26:30 INFO - 2015-12-28 13:26:30,196 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58079/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58079/tests/kraken/driver.html?testName=json-parse-financial) 13:26:30 INFO - 2015-12-28 13:26:30,758 DEBUG : BROWSER_OUTPUT: RSS: Main: 156086272 13:26:30 INFO - 2015-12-28 13:26:30,759 DEBUG : BROWSER_OUTPUT: 13:26:32 INFO - 2015-12-28 13:26:32,274 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58079/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58079/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:26:32 INFO - 2015-12-28 13:26:32,837 DEBUG : BROWSER_OUTPUT: RSS: Main: 160620544 13:26:32 INFO - 2015-12-28 13:26:32,837 DEBUG : BROWSER_OUTPUT: 13:26:34 INFO - 2015-12-28 13:26:34,546 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58079/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58079/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:26:35 INFO - 2015-12-28 13:26:35,135 DEBUG : BROWSER_OUTPUT: RSS: Main: 158257152 13:26:35 INFO - 2015-12-28 13:26:35,136 DEBUG : BROWSER_OUTPUT: 13:26:37 INFO - 2015-12-28 13:26:37,092 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58079/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58079/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:26:37 INFO - 2015-12-28 13:26:37,658 DEBUG : BROWSER_OUTPUT: RSS: Main: 165040128 13:26:37 INFO - 2015-12-28 13:26:37,658 DEBUG : BROWSER_OUTPUT: 13:26:39 INFO - 2015-12-28 13:26:39,977 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58079/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58079/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:26:40 INFO - 2015-12-28 13:26:40,559 DEBUG : BROWSER_OUTPUT: RSS: Main: 167714816 13:26:40 INFO - 2015-12-28 13:26:40,559 DEBUG : BROWSER_OUTPUT: 13:26:42 INFO - 2015-12-28 13:26:42,973 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58079/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58079/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:26:43 INFO - 2015-12-28 13:26:43,535 DEBUG : BROWSER_OUTPUT: RSS: Main: 166739968 13:26:43 INFO - 2015-12-28 13:26:43,535 DEBUG : BROWSER_OUTPUT: 13:26:45 INFO - 2015-12-28 13:26:45,169 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58079/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58079/tests/kraken/driver.html?testName=ai-astar) 13:26:45 INFO - 2015-12-28 13:26:45,419 DEBUG : BROWSER_OUTPUT: RSS: Main: 223444992 13:26:45 INFO - 2015-12-28 13:26:45,419 DEBUG : BROWSER_OUTPUT: 13:26:45 INFO - 2015-12-28 13:26:45,419 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:26:45 INFO - 2015-12-28 13:26:45,419 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:26:45 INFO - 2015-12-28 13:26:45,420 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:26:45 INFO - 2015-12-28 13:26:45,420 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:26:45 INFO - 2015-12-28 13:26:45,420 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;109;104;108;109;109;98;108;105;108 13:26:45 INFO - 2015-12-28 13:26:45,420 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;144;127;158;159;122;148;167;123;170;122 13:26:45 INFO - 2015-12-28 13:26:45,420 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;161;161;161;162;159;160;161;159;160 13:26:45 INFO - 2015-12-28 13:26:45,420 DEBUG : BROWSER_OUTPUT: |3;audio-fft;70;71;79;145;70;71;71;70;157;73 13:26:45 INFO - 2015-12-28 13:26:45,420 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;90;89;134;89;88;89;131;89;90;137 13:26:45 INFO - 2015-12-28 13:26:45,421 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;110;110;110;110;109;110;109;109 13:26:45 INFO - 2015-12-28 13:26:45,421 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;145;145;146;145;146;147;145;145;145 13:26:45 INFO - 2015-12-28 13:26:45,421 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;96;96;96;95;96;96;96;96 13:26:45 INFO - 2015-12-28 13:26:45,421 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;55;55;57;55;56;57;55;55;54;54 13:26:45 INFO - 2015-12-28 13:26:45,421 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;62;62;62;62;62;61;61;62;61;61 13:26:45 INFO - 2015-12-28 13:26:45,421 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;77;86;79;79;79;78;79;78;79;79 13:26:45 INFO - 2015-12-28 13:26:45,421 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;132;107;113;113;119;115;117;116;108;121 13:26:45 INFO - 2015-12-28 13:26:45,421 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;136;135;135;136;143;135;138;147;137;128 13:26:45 INFO - 2015-12-28 13:26:45,422 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;62;63;60;61;63;62;60;70;60 13:26:45 INFO - 2015-12-28 13:26:45,422 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:26:45 INFO - 2015-12-28 13:26:45,422 DEBUG : BROWSER_OUTPUT: __start_cc_report 13:26:45 INFO - 2015-12-28 13:26:45,422 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,857 13:26:45 INFO - 2015-12-28 13:26:45,422 DEBUG : BROWSER_OUTPUT: __end_cc_report 13:26:45 INFO - 2015-12-28 13:26:45,422 DEBUG : BROWSER_OUTPUT: __startTimestamp1451338005418__endTimestamp 13:26:45 INFO - 2015-12-28 13:26:45,422 DEBUG : BROWSER_OUTPUT: 13:26:45 INFO - 2015-12-28 13:26:45,426 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:26:45 INFO - 2015-12-28 13:26:45,426 DEBUG : BROWSER_OUTPUT: Number of tests: 14 13:26:45 INFO - 2015-12-28 13:26:45,426 DEBUG : BROWSER_OUTPUT: 13:26:45 INFO - 2015-12-28 13:26:45,426 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:106.60 Median:108.50 stddev:3.47 (3.2%) stddev-sans-first:3.64 13:26:45 INFO - 2015-12-28 13:26:45,426 DEBUG : BROWSER_OUTPUT: Values: 108.0 109.0 104.0 108.0 109.0 109.0 98.0 108.0 105.0 108.0 13:26:45 INFO - 2015-12-28 13:26:45,426 DEBUG : BROWSER_OUTPUT: 13:26:45 INFO - 2015-12-28 13:26:45,426 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:144.00 Median:153.00 stddev:19.26 (12.6%) stddev-sans-first:20.43 13:26:45 INFO - 2015-12-28 13:26:45,426 DEBUG : BROWSER_OUTPUT: Values: 144.0 127.0 158.0 159.0 122.0 148.0 167.0 123.0 170.0 122.0 13:26:45 INFO - 2015-12-28 13:26:45,426 DEBUG : BROWSER_OUTPUT: 13:26:45 INFO - 2015-12-28 13:26:45,427 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.50 Median:161.00 stddev:0.97 (0.6%) stddev-sans-first:1.01 13:26:45 INFO - 2015-12-28 13:26:45,427 DEBUG : BROWSER_OUTPUT: Values: 161.0 161.0 161.0 161.0 162.0 159.0 160.0 161.0 159.0 160.0 13:26:45 INFO - 2015-12-28 13:26:45,427 DEBUG : BROWSER_OUTPUT: 13:26:45 INFO - 2015-12-28 13:26:45,427 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:87.70 Median:71.00 stddev:33.59 (47.3%) stddev-sans-first:35.01 13:26:45 INFO - 2015-12-28 13:26:45,427 DEBUG : BROWSER_OUTPUT: Values: 70.0 71.0 79.0 145.0 70.0 71.0 71.0 70.0 157.0 73.0 13:26:45 INFO - 2015-12-28 13:26:45,427 DEBUG : BROWSER_OUTPUT: 13:26:45 INFO - 2015-12-28 13:26:45,427 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:102.60 Median:89.00 stddev:21.72 (24.4%) stddev-sans-first:22.56 13:26:45 INFO - 2015-12-28 13:26:45,427 DEBUG : BROWSER_OUTPUT: Values: 90.0 89.0 134.0 89.0 88.0 89.0 131.0 89.0 90.0 137.0 13:26:45 INFO - 2015-12-28 13:26:45,427 DEBUG : BROWSER_OUTPUT: 13:26:45 INFO - 2015-12-28 13:26:45,427 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:110.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 13:26:45 INFO - 2015-12-28 13:26:45,427 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 110.0 110.0 110.0 110.0 109.0 110.0 109.0 109.0 13:26:45 INFO - 2015-12-28 13:26:45,427 DEBUG : BROWSER_OUTPUT: 13:26:45 INFO - 2015-12-28 13:26:45,427 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 13:26:45 INFO - 2015-12-28 13:26:45,428 DEBUG : BROWSER_OUTPUT: Values: 145.0 145.0 145.0 146.0 145.0 146.0 147.0 145.0 145.0 145.0 13:26:45 INFO - 2015-12-28 13:26:45,428 DEBUG : BROWSER_OUTPUT: 13:26:45 INFO - 2015-12-28 13:26:45,428 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 13:26:45 INFO - 2015-12-28 13:26:45,428 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 96.0 96.0 96.0 95.0 96.0 96.0 96.0 96.0 13:26:45 INFO - 2015-12-28 13:26:45,428 DEBUG : BROWSER_OUTPUT: 13:26:45 INFO - 2015-12-28 13:26:45,428 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:55.30 Median:55.00 stddev:1.06 (1.9%) stddev-sans-first:1.12 13:26:45 INFO - 2015-12-28 13:26:45,428 DEBUG : BROWSER_OUTPUT: Values: 55.0 55.0 57.0 55.0 56.0 57.0 55.0 55.0 54.0 54.0 13:26:45 INFO - 2015-12-28 13:26:45,428 DEBUG : BROWSER_OUTPUT: 13:26:45 INFO - 2015-12-28 13:26:45,428 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:61.60 Median:62.00 stddev:0.52 (0.8%) stddev-sans-first:0.53 13:26:45 INFO - 2015-12-28 13:26:45,428 DEBUG : BROWSER_OUTPUT: Values: 62.0 62.0 62.0 62.0 62.0 61.0 61.0 62.0 61.0 61.0 13:26:45 INFO - 2015-12-28 13:26:45,428 DEBUG : BROWSER_OUTPUT: 13:26:45 INFO - 2015-12-28 13:26:45,428 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:79.30 Median:79.00 stddev:2.45 (3.1%) stddev-sans-first:2.46 13:26:45 INFO - 2015-12-28 13:26:45,428 DEBUG : BROWSER_OUTPUT: Values: 77.0 86.0 79.0 79.0 79.0 78.0 79.0 78.0 79.0 79.0 13:26:45 INFO - 2015-12-28 13:26:45,429 DEBUG : BROWSER_OUTPUT: 13:26:45 INFO - 2015-12-28 13:26:45,429 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:116.10 Median:116.50 stddev:7.11 (6.1%) stddev-sans-first:4.66 13:26:45 INFO - 2015-12-28 13:26:45,429 DEBUG : BROWSER_OUTPUT: Values: 132.0 107.0 113.0 113.0 119.0 115.0 117.0 116.0 108.0 121.0 13:26:45 INFO - 2015-12-28 13:26:45,429 DEBUG : BROWSER_OUTPUT: 13:26:45 INFO - 2015-12-28 13:26:45,429 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:137.00 Median:136.50 stddev:5.08 (3.7%) stddev-sans-first:5.37 13:26:45 INFO - 2015-12-28 13:26:45,429 DEBUG : BROWSER_OUTPUT: Values: 136.0 135.0 135.0 136.0 143.0 135.0 138.0 147.0 137.0 128.0 13:26:45 INFO - 2015-12-28 13:26:45,429 DEBUG : BROWSER_OUTPUT: 13:26:45 INFO - 2015-12-28 13:26:45,429 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.90 Median:62.50 stddev:3.45 (5.5%) stddev-sans-first:3.12 13:26:45 INFO - 2015-12-28 13:26:45,429 DEBUG : BROWSER_OUTPUT: Values: 68.0 62.0 63.0 60.0 61.0 63.0 62.0 60.0 70.0 60.0 13:26:45 INFO - 2015-12-28 13:26:45,429 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:26:45 INFO - 2015-12-28 13:26:45,429 DEBUG : BROWSER_OUTPUT: 13:26:46 INFO - 2015-12-28 13:26:46,101 INFO : Browser exited with error code: 0 13:26:46 INFO - 2015-12-28 13:26:46,149 INFO : Completed test kraken (00:00:57) 13:26:46 INFO - 2015-12-28 13:26:46,149 INFO : Starting test v8_7 13:26:46 INFO - 2015-12-28 13:26:46,149 DEBUG : operating with platform_type : linux_ 13:26:46 INFO - 2015-12-28 13:26:46,150 INFO : Initialising browser for v8_7 test... 13:26:46 INFO - 2015-12-28 13:26:46,156 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3T1zmN/profile http://localhost:58079/getInfo.html 13:26:49 INFO - 2015-12-28 13:26:49,651 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:26:49 INFO - 2015-12-28 13:26:49,652 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:26:49 INFO - 2015-12-28 13:26:49,652 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 13:26:49 INFO - 2015-12-28 13:26:49,652 DEBUG : BROWSER_OUTPUT: __metrics 13:26:49 INFO - 2015-12-28 13:26:49,809 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] 13:26:50 INFO - 2015-12-28 13:26:50,949 INFO : Browser initialized. 13:26:50 INFO - 2015-12-28 13:26:50,950 INFO : Running cycle 1/1 for v8_7 test... 13:26:50 INFO - 2015-12-28 13:26:50,950 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3T1zmN/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:27:02 INFO - 2015-12-28 13:27:02,570 DEBUG : BROWSER_OUTPUT: RSS: Main: 128561152 13:27:02 INFO - 2015-12-28 13:27:02,571 DEBUG : BROWSER_OUTPUT: 13:27:23 INFO - 2015-12-28 13:27:23,907 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58079/tests/v8_7/run.html (next: http://localhost:58079/tests/v8_7/run.html) 13:27:24 INFO - 2015-12-28 13:27:24,165 DEBUG : BROWSER_OUTPUT: RSS: Main: 427872256 13:27:24 INFO - 2015-12-28 13:27:24,165 DEBUG : BROWSER_OUTPUT: 13:27:24 INFO - 2015-12-28 13:27:24,166 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:27:24 INFO - 2015-12-28 13:27:24,166 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:27:24 INFO - 2015-12-28 13:27:24,166 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:27:24 INFO - 2015-12-28 13:27:24,166 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:27:24 INFO - 2015-12-28 13:27:24,166 DEBUG : BROWSER_OUTPUT: |0;Richards;163.8001638001638 13:27:24 INFO - 2015-12-28 13:27:24,166 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;164.93485073396008 13:27:24 INFO - 2015-12-28 13:27:24,166 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.6420581655481 13:27:24 INFO - 2015-12-28 13:27:24,166 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5020 13:27:24 INFO - 2015-12-28 13:27:24,166 DEBUG : BROWSER_OUTPUT: |4;RayTrace;933.7068160597572 13:27:24 INFO - 2015-12-28 13:27:24,167 DEBUG : BROWSER_OUTPUT: |5;Earley;552.1811154058531 13:27:24 INFO - 2015-12-28 13:27:24,167 DEBUG : BROWSER_OUTPUT: |6;Boyer;10536.842105263158 13:27:24 INFO - 2015-12-28 13:27:24,167 DEBUG : BROWSER_OUTPUT: |7;RegExp;24071.428571428572 13:27:24 INFO - 2015-12-28 13:27:24,167 DEBUG : BROWSER_OUTPUT: |8;Splay;529.1005291005291 13:27:24 INFO - 2015-12-28 13:27:24,167 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 13:27:24 INFO - 2015-12-28 13:27:24,167 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:27:24 INFO - 2015-12-28 13:27:24,167 DEBUG : BROWSER_OUTPUT: __startTimestamp1451338044159__endTimestamp 13:27:24 INFO - 2015-12-28 13:27:24,167 DEBUG : BROWSER_OUTPUT: 13:27:24 INFO - 2015-12-28 13:27:24,167 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:27:24 INFO - 2015-12-28 13:27:24,168 DEBUG : BROWSER_OUTPUT: Number of tests: 10 13:27:24 INFO - 2015-12-28 13:27:24,168 DEBUG : BROWSER_OUTPUT: 13:27:24 INFO - 2015-12-28 13:27:24,168 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:163.80 Median:163.80 stddev:0.00 (0.0%) 13:27:24 INFO - 2015-12-28 13:27:24,168 DEBUG : BROWSER_OUTPUT: Values: 163.8 13:27:24 INFO - 2015-12-28 13:27:24,168 DEBUG : BROWSER_OUTPUT: 13:27:24 INFO - 2015-12-28 13:27:24,168 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:164.93 Median:164.93 stddev:0.00 (0.0%) 13:27:24 INFO - 2015-12-28 13:27:24,168 DEBUG : BROWSER_OUTPUT: Values: 164.9 13:27:24 INFO - 2015-12-28 13:27:24,168 DEBUG : BROWSER_OUTPUT: 13:27:24 INFO - 2015-12-28 13:27:24,169 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.64 Median:279.64 stddev:0.00 (0.0%) 13:27:24 INFO - 2015-12-28 13:27:24,169 DEBUG : BROWSER_OUTPUT: Values: 279.6 13:27:24 INFO - 2015-12-28 13:27:24,169 DEBUG : BROWSER_OUTPUT: 13:27:24 INFO - 2015-12-28 13:27:24,169 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5020.00 Median:5020.00 stddev:0.00 (0.0%) 13:27:24 INFO - 2015-12-28 13:27:24,170 DEBUG : BROWSER_OUTPUT: Values: 5020.0 13:27:24 INFO - 2015-12-28 13:27:24,170 DEBUG : BROWSER_OUTPUT: 13:27:24 INFO - 2015-12-28 13:27:24,170 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:933.71 Median:933.71 stddev:0.00 (0.0%) 13:27:24 INFO - 2015-12-28 13:27:24,170 DEBUG : BROWSER_OUTPUT: Values: 933.7 13:27:24 INFO - 2015-12-28 13:27:24,170 DEBUG : BROWSER_OUTPUT: 13:27:24 INFO - 2015-12-28 13:27:24,171 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:552.18 Median:552.18 stddev:0.00 (0.0%) 13:27:24 INFO - 2015-12-28 13:27:24,171 DEBUG : BROWSER_OUTPUT: Values: 552.2 13:27:24 INFO - 2015-12-28 13:27:24,171 DEBUG : BROWSER_OUTPUT: 13:27:24 INFO - 2015-12-28 13:27:24,171 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10536.84 Median:10536.84 stddev:0.00 (0.0%) 13:27:24 INFO - 2015-12-28 13:27:24,172 DEBUG : BROWSER_OUTPUT: Values: 10536.8 13:27:24 INFO - 2015-12-28 13:27:24,172 DEBUG : BROWSER_OUTPUT: 13:27:24 INFO - 2015-12-28 13:27:24,172 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24071.43 Median:24071.43 stddev:0.00 (0.0%) 13:27:24 INFO - 2015-12-28 13:27:24,172 DEBUG : BROWSER_OUTPUT: Values: 24071.4 13:27:24 INFO - 2015-12-28 13:27:24,173 DEBUG : BROWSER_OUTPUT: 13:27:24 INFO - 2015-12-28 13:27:24,173 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:529.10 Median:529.10 stddev:0.00 (0.0%) 13:27:24 INFO - 2015-12-28 13:27:24,173 DEBUG : BROWSER_OUTPUT: Values: 529.1 13:27:24 INFO - 2015-12-28 13:27:24,173 DEBUG : BROWSER_OUTPUT: 13:27:24 INFO - 2015-12-28 13:27:24,173 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 13:27:24 INFO - 2015-12-28 13:27:24,173 DEBUG : BROWSER_OUTPUT: Values: 4835.7 13:27:24 INFO - 2015-12-28 13:27:24,173 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:27:24 INFO - 2015-12-28 13:27:24,173 DEBUG : BROWSER_OUTPUT: 13:27:24 INFO - 2015-12-28 13:27:24,809 INFO : Browser exited with error code: 0 13:27:24 INFO - 2015-12-28 13:27:24,823 INFO : Completed test v8_7 (00:00:38) 13:27:25 INFO - 2015-12-28 13:27:25,229 INFO : Completed test suite (00:20:05) 13:27:25 INFO - 2015-12-28 13:27:25,229 DEBUG : Working with test: dromaeo_css 13:27:25 INFO - 2015-12-28 13:27:25,229 DEBUG : Generating results file: dromaeo_css 13:27:25 INFO - 2015-12-28 13:27:25,231 DEBUG : Working with test: kraken 13:27:25 INFO - 2015-12-28 13:27:25,231 DEBUG : Generating results file: kraken 13:27:25 INFO - 2015-12-28 13:27:25,231 INFO : javascript benchmark 13:27:25 INFO - 2015-12-28 13:27:25,231 DEBUG : Working with test: v8_7 13:27:25 INFO - 2015-12-28 13:27:25,231 DEBUG : Generating results file: v8_7 13:27:25 INFO - 2015-12-28 13:27:25,232 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:27:25 INFO - 2015-12-28 13:27:25,282 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,53,35]] 13:27:25 INFO - 2015-12-28 13:27:25,282 DEBUG : process_Request line: dromaeo_css 7146.88 graph.html#tests=[[72,53,35]] 13:27:25 INFO - 2015-12-28 13:27:25,282 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:27:25 INFO - 2015-12-28 13:27:25,319 DEBUG : process_Request line: kraken 1464.30 graph.html#tests=[[232,53,35]] 13:27:25 INFO - 2015-12-28 13:27:25,319 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:27:25 INFO - 2015-12-28 13:27:25,348 DEBUG : process_Request line: v8_7 23389.83 graph.html#tests=[[230,53,35]] 13:27:25 INFO - 2015-12-28 13:27:25,349 INFO : javascript benchmark 13:27:25 INFO - 2015-12-28 13:27:25,353 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3341.632420433752, 3397.269587038786, 3420.127867393814, 3424.948625770612, 3453.740969427292, 5577.8605534861645, 5607.579431542636, 5614.326280846304, 5617.269754931864, 5617.831465056055, 5601.131824567188, 5660.915086273699, 5666.5183459406, 5672.17753425754, 5672.205891175228, 4970.701757894538, 5130.794768209276, 5150.072986862363, 5176.456472070435, 5192.454792246816, 5131.692098474104, 5136.794528218867, 5153.6392452528335, 5157.277981082651, 5159.896802063975, 5078.4921507849285, 5100.260462232974, 5151.459096794839, 5151.871203219912, 5161.251618515313, 5094.949050509503, 5131.61512886535, 5254.3169387979315, 5260.316158899319, 5262.815801446931, 5118.488151184889, 5147.6654017488745, 5166.044281807877, 5189.273501709764, 5191.273221748958, 5245.842624721265, 5254.0805359062015, 5349.786008559653, 5451.64564303319, 5452.591055670801, 6064.436504065855, 6072.981358726227, 6079.300880398767, 6090.421409966046, 6099.207103076572, 6085.208922840046, 6091.269047714259, 6093.939060609381, 6097.268327800648, 6122.663253521055, 5478.397376288605, 5557.5831812613815, 5584.832455026356, 5703.201551782754, 5712.11462223356, 6010.519158467312, 6199.690015499297, 6201.844953876189, 6209.844753881189, 6211.09939058834, 6027.246594175728, 6063.181470501426, 6065.514758819284, 6072.787452439232, 6078.0, 5916.23088998436, 5982.4017598239825, 6013.0, 6040.365761595057, 6122.062734707273, 5938.732757025944, 6063.9090413643835, 6096.420840020191, 6102.633841969496, 6104.38956104386, 5867.589268751231, 6097.634141951497, 6140.048292514667, 6141.570090093651, 6148.8770224595255, 4579.244424669892, 4592.88517787058, 4594.471635761864, 4594.95405045952, 4597.195490789099, 4050.9189816204102, 4108.055147316074, 4110.938335924963, 4111.6299533042165, 4112.09533902541, 5698.430156984268, 5747.971260143672, 5759.107338362561, 5760.6255593386295, 5765.250517432707, 6074.848128796727, 6095.420935011167, 6098.817035488943, 6099.969500152471, 6110.572259941761, 5561.110222364402, 5663.377028526858, 5699.572532060112, 5769.884602308014, 5790.652560846363, 5233.241180028875, 5233.921491177635, 5281.577473802086, 5288.2596436498925, 5298.09932311508, 6079.544034197453, 6301.212348456443, 6336.271328797156, 6340.365963403715, 6340.809775706736, 5913.556483263773, 6062.393760623902, 6151.753929842756, 6153.753849846135, 6155.47678447337, 6363.904541431974, 6389.105525226565, 6389.584676995981, 6393.392627700361, 6396.296407395276, 5819.5635327351465, 6015.2781666200335, 6154.230721159855, 6174.969125154345, 6182.629042257479, 6057.091436284416, 6142.447179753844, 6144.047672610753, 6148.3236843948025, 6150.384961503813, 5984.0, 5997.790077347272, 6001.06983417571, 6006.909896351645, 6007.249093863267, 5673.375928647928, 5791.565632577489, 5898.616589921641, 6010.519158467225, 6013.067974463965, 5861.794837180678, 5868.38381969887, 5877.853053673693, 5879.911801323069, 5894.351621321737, 5924.200232968494, 5943.524518038633, 5974.820755377345, 5975.312839023568, 5977.7310021050025, 5586.13414920688, 5684.545236381162, 5771.336296325976, 5824.737886795019, 5881.117832325185], "unit": "ms", "name": "dojo.html", "value": 5589.760114481936}, {"lowerIsBetter": false, "replicates": [602.7046747093923, 633.0346222011432, 640.260499123512, 640.3628389752197, 645.0839807473386, 42592.36111458327, 43652.345214821806, 43698.0, 43700.56299437005, 43715.344269835936, 46286.76856615712, 46885.0, 46936.295955560694, 46967.530324696745, 46972.0, 8198.38512111591, 8316.625751841182, 9142.999999999984, 9305.581248843784, 10396.11633011195, 10698.572057117706, 10717.785644287149, 10830.350178989247, 10840.186985976045, 10852.891471085268, 10688.78622427555, 10699.518521666505, 10821.621243256488, 10850.403227822466, 10854.185936054788, 10733.570657173703, 10837.729056773565, 10840.512176952056, 10846.240763146505, 10857.891421085767, 10598.947005265001, 10784.514696838583, 10791.298565593212, 10793.5682572697, 10842.512086956105, 43234.78382608067, 43546.346804797955, 43616.12767744659, 43686.56313436857, 43801.12397752027, 3661.212839239576, 3721.4603882436895, 4036.6770658347264, 4296.9570304297185, 4299.355096735515, 33305.66694333074, 33341.0, 33365.16587085318, 33395.332093357996, 33637.83181084079, 3355.4799006154085, 3400.1669590950128, 3408.4442358954743, 3425.811580363079, 3535.1515636247373, 328113.0, 328365.0, 330210.0, 330319.0, 330550.0, 56752.43247567554, 57506.42493575011, 63753.68123159447, 64243.0, 69099.30900691029, 66086.0, 66293.0, 66937.33062669408, 66942.66528667326, 66954.0, 18048.09759512019, 18051.54871128206, 18240.0, 18298.359557415428, 18309.267629294678, 12606.55877044299, 12786.808197877039, 12794.744105117845, 12803.679908002188, 12829.23024618526, 20547.8972605136, 20836.583268334547, 20933.79066209349, 20964.895175524023, 20996.685049724267, 7945.602719863984, 8159.67361305553, 8172.915906443819, 8178.427510074357, 8185.4270201085355, 986.5954958466995, 991.7768502086973, 1012.4937531234383, 1086.1907878630313, 1134.2910680824484, 29177.7082229175, 29658.55512167319, 29737.0, 30387.544186837215, 31016.379672406427, 1109.9056580190775, 1129.728865072393, 1208.2871106047473, 1212.7811549392804, 1223.559518573313, 13213.867861321263, 14693.485727999469, 14825.851741482662, 15039.172845493384, 15699.450519231772, 293489.0, 294737.0, 295503.0, 296197.0, 296334.0, 50452.747736261816, 50813.0, 50857.74571127121, 50906.236406453936, 51071.0, 1494.2080697230485, 1496.102338596855, 1497.4160077569757, 1505.7289687856291, 1506.6308754355252, 27859.72140278571, 28975.85512072426, 29650.851745741133, 29780.55329170021, 29843.701562984093, 46674.29988550243, 47861.04277914353, 48719.26921096257, 52711.20933185929, 53787.462125378246, 250251.0, 250449.0, 250916.0, 251413.0, 251468.0, 33460.163495911824, 33739.3252134951, 33804.83097584496, 33858.15354616154, 33892.49161262633, 46277.30584041309, 46950.53049469461, 47106.76446617745, 47259.291110634054, 47596.0, 38729.41905871358, 38772.224555509296, 38822.6117738819, 38955.61044389633, 40170.39744403778, 38893.416598750475, 40094.0, 40586.391204131374, 40705.0, 41246.0, 37405.251894962494, 38184.23631527298, 38243.42634860535, 38425.80787096047, 38475.615243847205, 34155.31689366149, 34833.30333393368, 35071.123221918635, 35322.64677353194, 37174.07064823401, 25538.872305638353, 26081.217563473125, 26108.8694556526, 26337.20988370352, 28251.858740706986], "unit": "ms", "name": "ext.html", "value": 19992.441844647572}, {"lowerIsBetter": false, "replicates": [388.6657474571868, 391.3992022245852, 394.3867286369694, 395.39701954519353, 399.3909288335287, 12813.871861281385, 15712.114546254437, 17825.197866096023, 18708.719369209473, 18736.156872940734, 13713.862861371383, 14006.579802605938, 14007.719845603082, 20197.99010049499, 20699.896500517512, 4922.163232250508, 5030.723310217936, 5036.471170527097, 5039.19372900336, 5039.44566097729, 3975.244703506339, 4035.273650742865, 4968.453470118284, 5400.83797486076, 5544.86137846553, 5443.455654434545, 5470.0, 5471.37079235887, 5485.149801780711, 5490.972545137269, 5306.946930530684, 5354.437784032699, 5354.759035843396, 5372.435894231108, 5376.91934620981, 4631.976840115812, 4639.86080417588, 4641.76791160444, 4652.185867473178, 4662.8134874604975, 15590.844091559053, 16026.118563479004, 16125.43560975372, 16164.191790410432, 16173.867829251956, 2293.243229734184, 2298.2990187992655, 2320.1183550250967, 2326.441654003044, 2491.9750802491926, 11034.337939723562, 11188.608398706006, 11303.943480282629, 11348.886511134866, 11533.884661153365, 1830.057520377007, 1859.2098358197848, 1908.4656296237076, 1924.8845069295887, 1973.1416833677397, 67685.3231467684, 67780.0, 68102.3189768106, 69077.65461172712, 69265.3073469269, 7641.3886889048745, 7651.464397492122, 7757.72847950319, 7848.13670496245, 7856.764297070983, 9502.097300756417, 9533.380330278509, 9543.618255269712, 9546.140847323773, 9549.570269337897, 6156.415140561639, 6267.185265915402, 6285.96857015712, 6298.338674439209, 6300.117983482316, 6208.0, 6253.6873156342, 6260.0, 6281.434670879643, 6322.778702745474, 3549.591796943333, 3609.657082577151, 3624.6919011884283, 3626.111602657366, 3628.1473853644375, 1214.684182112657, 1240.1690867119053, 1273.4269578689627, 1313.4811749359142, 1321.0356439799, 457.5584560898749, 464.1992562829093, 472.8652334084769, 493.64457590534755, 513.7251570409812, 10283.331583447052, 11373.658790236306, 12213.145079844504, 12288.692782680326, 12313.56902508408, 488.5749398023671, 496.63249195595, 497.9502049794992, 513.4659953648164, 522.146290814521, 5431.565474762009, 6500.057491663682, 6702.83242918931, 6708.262091169968, 6790.7623233186605, 608693.0, 624083.0, 631912.0, 633994.0, 647884.0, 84558.57720711357, 85216.0, 86182.56908715416, 86361.13638863657, 88014.55992719995, 530.8301343570098, 533.4105813076573, 533.6104643610108, 534.2360424592791, 534.2573822386885, 11410.486528106088, 11539.07687385024, 11552.6534203974, 11595.072394208275, 11644.5342186315, 38907.02732431712, 39202.01994950149, 39210.2157956845, 40527.1894562113, 40735.38896916608, 52154.73922630362, 53112.0, 53214.73392633012, 53858.46141538535, 54785.17822232749, 7717.421193410629, 7763.301302882542, 7833.529988200727, 7924.920750792418, 7942.324902383131, 13683.315834208448, 14058.718825623635, 14194.148351098967, 14227.50203742864, 14322.069065511125, 12124.939375303067, 12127.0, 12228.510859565518, 12269.509219631473, 12321.199122057038, 11628.360440175533, 11930.343831089373, 12121.939390302992, 12296.139270250997, 12443.93778031104, 10277.280590358901, 10722.356658600196, 11918.165728398928, 12099.879001210227, 12146.453409596767, 7782.260685234894, 7923.20767923203, 14971.176585287914, 15143.545693629208, 17587.208575614382, 10856.565737370733, 11165.888341116484, 11237.7752444949, 11274.718132046764, 17309.65380692404], "unit": "ms", "name": "jquery.html", "value": 7740.638224850015}, {"lowerIsBetter": false, "replicates": [1553.1612929018331, 1555.9844401555988, 1807.6203997160596, 1819.5087326421865, 1848.5009047557155, 7031.0, 7179.425645948325, 7957.323627491663, 8100.068492123408, 8100.149484304145, 7573.0912290525075, 7690.077190737119, 7766.339861111798, 7779.805504862381, 7780.961095194516, 2375.7030371203555, 2412.843165194257, 2413.5414271288487, 2414.9758502415016, 2416.6254230594286, 2029.391182645208, 2128.9148434062618, 2326.1858349577683, 2377.0135393811547, 2411.131992482705, 2271.636538153896, 2284.7372552156467, 2290.9083636654514, 2295.116380193629, 2301.42464383904, 2295.345826439465, 2319.976800231993, 2320.8259380546356, 2320.8859747321294, 2320.9883950580306, 2361.114582031738, 2424.6120620700603, 2426.8422552534207, 2427.987860060706, 2428.963565546518, 7976.601169941479, 8034.598270086531, 8038.959805200995, 8049.517028978222, 8050.235227653364, 4839.395075615548, 4892.9510704892855, 4904.068227036852, 4904.068227036852, 4906.165951788169, 3238.8380580970856, 3309.5035744638258, 3358.0261724099983, 3369.2756057447523, 3372.1401042733946, 998.2513115163628, 999.4353190447447, 1005.3113617172187, 1032.9845052324222, 1033.5400746667735, 10596.0, 10602.787944241149, 10607.628732994308, 10615.09771669409, 10644.467776611216, 4525.818967241339, 4534.13851368239, 4606.907861842811, 4625.514320996314, 4676.415448068991, 9216.216621587106, 9242.260619150451, 9242.537873106452, 9254.907450925404, 9266.907330926604, 5010.674306170087, 5012.24816277554, 5013.548780609763, 5018.799248030111, 5023.472535383805, 4584.0, 4591.540845915449, 4593.885152871205, 4594.1271158479785, 4606.677532572688, 3866.168773713665, 3917.804109794499, 3920.4315374270573, 3945.980270098631, 3955.7626542407547, 1137.3005601555149, 1177.140687298277, 1244.1912756708211, 1301.4208677138772, 1303.1594621469098, 1145.2040831621944, 1145.3414286785132, 1185.2829038431626, 1199.5082016373244, 1222.2727477151082, 7459.104907411145, 7508.549487030796, 7519.924800752032, 7558.13081495624, 7768.689252429839, 1198.2271434924426, 1200.0939290835538, 1207.7644859252362, 1218.9268643881396, 1222.7554489102215, 5851.327097383855, 5921.526277897758, 5929.407059294036, 5932.911006334908, 5934.762609495572, 9327.533623318806, 9735.075167859042, 9754.219662426989, 9754.951225243829, 9771.022897710172, 9665.855012174823, 9681.467519286365, 9686.370385924893, 9698.418094914186, 9698.6120555177, 7381.261873812683, 7431.29402706742, 7462.179160292363, 7470.626468676544, 7569.621518924032, 7159.355657990805, 7185.317394847481, 7190.06529151207, 7242.239564845615, 7255.637218139177, 8356.6239519223, 8591.613377397907, 8593.097724738813, 8603.053664096818, 8606.956965215133, 8649.394542381973, 8660.566971651266, 8720.258778003687, 8720.607572659119, 8742.12578742146, 7032.929670703227, 7076.540024898365, 7077.256888026683, 7078.1860086090755, 7086.822829429306, 6940.687669054803, 7830.657167694186, 7882.5270483771155, 7886.329661978796, 7886.526808391515, 7212.819679508054, 7314.34170924598, 7323.267673232847, 7326.377257933135, 7431.702731890664, 7233.0597022386755, 7269.818254543678, 7316.195218526064, 7367.926320736939, 7381.298776616213, 7427.8143046424275, 7457.142428620561, 7460.253974602496, 7461.4403919705155, 7462.888056679263, 6659.633720145439, 6711.328867113445, 6780.288069752803, 6809.455243580601, 6819.386255237053, 6825.965870170618, 6846.657667116724, 6852.451803855779, 6865.897011544731, 6877.518573699993], "unit": "ms", "name": "mootools.html", "value": 4657.397961158218}, {"lowerIsBetter": false, "replicates": [366.8422578291335, 371.32048351516727, 372.3260897775027, 376.40527965814016, 382.6670796407128, 5914.733836977335, 5921.230240068796, 5974.0, 5979.461848433634, 6011.188489553909, 5816.476517113459, 5912.467877890989, 5918.201042859213, 5945.286565612122, 5969.373215812342, 4674.205385084527, 4680.4149481314835, 4686.9296960545535, 4687.086018226447, 4691.741954192518, 4684.391029166203, 4687.086018226447, 4687.132880417117, 4690.882727931795, 4692.882677933062, 4568.908621827562, 4659.4175728034, 4669.649776266793, 4726.598239149676, 4736.3842700448895, 4699.95300047002, 4703.247480403136, 4706.176419126657, 4722.244440889458, 4723.4568024677255, 3978.880633580968, 4205.894852628709, 4206.3690446432975, 4213.988642725754, 4217.367394890791, 5558.888822223533, 5601.047821870292, 5648.350439699405, 5652.3217213934595, 5666.235058267122, 5406.189071639246, 5413.188021796723, 5428.701421421821, 5429.53848922842, 5431.131019036935, 6318.957372033609, 6325.304216536178, 6326.810195694136, 6328.050792381134, 6328.7468501260355, 4523.321501774727, 4612.238980568202, 4616.0, 4619.260918253063, 4626.097910907374, 6471.741130354781, 6477.54657173998, 6478.222613286389, 6484.967575162094, 6487.351264873475, 4730.195866702668, 4736.289556566542, 4736.64475164364, 4737.147313483606, 4741.454732705714, 4747.0505898820375, 4794.0, 4796.352492413549, 4803.663743537919, 4803.927941080887, 5498.092814685612, 5508.834734957958, 5512.145617429305, 5518.19986102021, 5518.779248830002, 6439.613623182624, 6452.419282264619, 6458.031295305742, 6458.451031662267, 6458.838529036811, 1727.5076603168036, 1727.6544691061838, 1727.7926648802224, 1727.9891263610928, 1728.438257566296, 1208.8609809871978, 1210.7396909664465, 1213.878612138779, 1214.4474264209764, 1240.3178251961385, 6222.439980401786, 6225.159603453566, 6226.40849119333, 6227.595206311576, 6231.3145553989025, 6632.237292711304, 6636.0, 6636.30318816527, 6636.701348439332, 6639.933600664028, 6140.692965351804, 6214.1921550198185, 6216.160818289473, 6218.440340369389, 6220.409061139185, 3634.890953271406, 3671.7429779915683, 3672.889813305605, 3673.44898265257, 3673.577538583044, 6606.7026983785845, 6687.933120668828, 6751.527393082437, 6852.109225800614, 6911.205211400653, 6766.25571187169, 6776.728930842711, 6785.42323902464, 6788.932110678928, 6805.863882722318, 6801.591904485746, 6804.285550017276, 6806.829829254309, 6812.659367031629, 6815.727370905208, 6465.838354040999, 6595.967020164869, 6606.273309935807, 6608.900866487103, 6613.900791488228, 6610.4050635443045, 6622.07290979273, 6627.304133065959, 6630.867382652416, 6637.70130344126, 6799.11611490503, 6800.727970881109, 6803.25164231944, 6813.89779153323, 6815.182178138457, 4628.930566041579, 4714.057188562233, 4716.268978308368, 4716.33971244033, 4716.905661886812, 6604.636744979072, 6611.041398997215, 6612.074309596756, 6615.768448104293, 6616.305287944697, 6437.645929473924, 6453.806385808433, 6455.48356131499, 6458.031295305742, 6463.547551671526, 6340.1123842661145, 6411.903821442589, 6427.967860160669, 6440.420362167428, 6444.065610486547, 6337.017762246859, 6340.714667839866, 6342.809715708536, 6343.11196432509, 6348.0, 6382.680865956777, 6471.288158302489, 6476.255230648348, 6476.676166191766, 6479.546431749733, 6254.8123556293385, 6256.749730010749, 6262.0, 6263.154474145932, 6263.185785847811], "unit": "ms", "name": "prototype.html", "value": 4907.796411149014}, {"lowerIsBetter": false, "replicates": [834.8330333933214, 873.3362644390265, 907.6596276396353, 932.1051790281331, 934.6635211323922, 14634.0, 14957.850421495808, 14980.550583482485, 14982.0, 14994.775078373834, 14283.571492855204, 14343.497977570787, 14368.568942931728, 14393.06445081069, 14393.64015899603, 773.2692605487816, 791.8970533830623, 915.4370062411635, 935.3125452792192, 936.9906300937006, 926.5691453474133, 926.9073092690711, 932.0, 938.3947353956694, 938.7465384346223, 817.9672813087469, 968.5157421289356, 977.7897751983322, 977.9022097790199, 980.8675828763132, 823.1768231768202, 960.8894977077621, 969.7914948286152, 970.3450171134491, 970.5389939778619, 719.4855678190119, 723.2803360656128, 724.2901956083068, 724.90213821134, 725.5537844225815, 14960.70078598422, 15059.774103388349, 15073.623159420993, 15084.472043478425, 15085.773713394308, 13233.470661173542, 13788.586342409744, 14376.856231437761, 14458.421663133462, 14498.057626254365, 11047.72380690481, 11348.09215262777, 11432.37121958292, 11439.19925605208, 11445.198836081478, 3738.065483629093, 3763.9811800941093, 3784.5836957934607, 3809.8095095245126, 3850.6726928211137, 52098.47901520974, 52214.0, 54128.72935635336, 54239.186412204246, 54392.728036359964, 10390.324628899098, 10459.320144190604, 10482.423466709251, 10700.785984280426, 10910.945445272722, 20328.898355508423, 20380.18479260813, 20395.59208815845, 20404.591908161754, 20414.79585204129, 7839.6472158752995, 8025.0, 8152.673893044212, 8177.509349439053, 8353.540555269397, 4637.072585482917, 4722.740249286322, 4777.546133117348, 4832.516748325139, 4960.057589058068, 3310.2882880180396, 3340.9498857517156, 3344.4983252512316, 3347.6484969078383, 3357.9496307555405, 481.08113503208705, 498.39942868842957, 509.36075225591645, 513.1071934833437, 519.8128673677473, 553.1143715399272, 643.340575909687, 646.7194953991124, 669.1835960128635, 676.6549059979446, 8939.597718102701, 8945.642174312954, 9378.812423751488, 9400.717978460658, 9746.512674366253, 602.8251806975928, 668.3350066683681, 707.5507053021369, 714.1679942866606, 736.7716008037526, 4126.711130220916, 4215.641670457984, 4330.848420305274, 4378.562143785596, 4402.625776809007, 66163.33836661668, 66560.0, 67262.0, 67377.32622673809, 67400.32599674039, 58883.70558147182, 59610.70194648999, 59995.0, 60096.699516502136, 61057.389426106056, 54028.18957715637, 54120.0, 54936.725316373166, 55571.72214138904, 55624.16563751547, 7932.762017139495, 8495.74512764618, 8541.05916658822, 8731.825363492568, 8812.074732153287, 39250.0, 39824.2035159301, 40083.0, 40239.0, 40242.1951560973, 49737.502624973284, 52272.738636306574, 52597.47402526079, 53090.46909530855, 53363.733181333846, 8290.08809030994, 8322.6670933162, 8371.121032291521, 8458.703945361884, 8601.311895048257, 10969.0, 10972.561097556008, 10991.175661825235, 11104.944475277573, 11180.832287515856, 11110.666679999289, 11184.0, 11280.435978200892, 11321.207515473838, 11398.886011139783, 11528.308301501937, 11616.573110932126, 11704.648860533856, 12019.399030048287, 12212.694682633006, 10620.022019659275, 10819.891801081889, 10938.179636527133, 10970.561177552809, 11020.063294619726, 10047.899521004696, 10657.467126643482, 10802.513886874953, 10821.945890270814, 10963.671089867317, 9893.35693179941, 9982.700518984442, 10002.699919002442, 10084.0, 10124.949375253076], "unit": "ms", "name": "yui.html", "value": 6739.0092205496485}], "name": "dromaeo_css", "value": 7146.879657683462}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 109.0, 104.0, 108.0, 109.0, 109.0, 98.0, 108.0, 105.0, 108.0], "unit": "ms", "name": "ai-astar", "value": 106.6}, {"lowerIsBetter": true, "replicates": [144.0, 127.0, 158.0, 159.0, 122.0, 148.0, 167.0, 123.0, 170.0, 122.0], "unit": "ms", "name": "audio-beat-detection", "value": 144.0}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 161.0, 161.0, 162.0, 159.0, 160.0, 161.0, 159.0, 160.0], "unit": "ms", "name": "audio-dft", "value": 160.5}, {"lowerIsBetter": true, "replicates": [70.0, 71.0, 79.0, 145.0, 70.0, 71.0, 71.0, 70.0, 157.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 87.7}, {"lowerIsBetter": true, "replicates": [90.0, 89.0, 134.0, 89.0, 88.0, 89.0, 131.0, 89.0, 90.0, 137.0], "unit": "ms", "name": "audio-oscillator", "value": 102.6}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 110.0, 110.0, 110.0, 109.0, 110.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.5}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 145.0, 146.0, 145.0, 146.0, 147.0, 145.0, 145.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.4}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [55.0, 55.0, 57.0, 55.0, 56.0, 57.0, 55.0, 55.0, 54.0, 54.0], "unit": "ms", "name": "json-parse-financial", "value": 55.3}, {"lowerIsBetter": true, "replicates": [62.0, 62.0, 62.0, 62.0, 62.0, 61.0, 61.0, 62.0, 61.0, 61.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 61.6}, {"lowerIsBetter": true, "replicates": [77.0, 86.0, 79.0, 79.0, 79.0, 78.0, 79.0, 78.0, 79.0, 79.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 79.3}, {"lowerIsBetter": true, "replicates": [132.0, 107.0, 113.0, 113.0, 119.0, 115.0, 117.0, 116.0, 108.0, 121.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 116.1}, {"lowerIsBetter": true, "replicates": [136.0, 135.0, 135.0, 136.0, 143.0, 135.0, 138.0, 147.0, 137.0, 128.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 137.0}, {"lowerIsBetter": true, "replicates": [68.0, 62.0, 63.0, 60.0, 61.0, 63.0, 62.0, 60.0, 70.0, 60.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 62.9}], "name": "kraken", "value": 1464.2999999999997}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [163.8001638001638], "unit": "score", "name": "Richards", "value": 215.5187099999999}, {"lowerIsBetter": false, "replicates": [164.93485073396008], "unit": "score", "name": "DeltaBlue", "value": 400.87343399999986}, {"lowerIsBetter": false, "replicates": [279.6420581655481], "unit": "score", "name": "Encrypt", "value": 951.8632560000003}, {"lowerIsBetter": false, "replicates": [5020.0], "unit": "score", "name": "Decrypt", "value": 53.0241035856574}, {"lowerIsBetter": false, "replicates": [933.7068160597572], "unit": "score", "name": "RayTrace", "value": 792.5282190000003}, {"lowerIsBetter": false, "replicates": [552.1811154058531], "unit": "score", "name": "Earley", "value": 1206.964493}, {"lowerIsBetter": false, "replicates": [10536.842105263158], "unit": "score", "name": "Boyer", "value": 63.25073426573423}, {"lowerIsBetter": false, "replicates": [24071.428571428572], "unit": "score", "name": "RegExp", "value": 37.845074183976266}, {"lowerIsBetter": false, "replicates": [529.1005291005291], "unit": "score", "name": "Splay", "value": 154.01798999999997}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 23389.82942383538}]} 13:27:25 INFO - RETURN: dromaeo_css: 7146.88 13:27:25 INFO - RETURN: kraken: 1464.30 13:27:25 INFO - RETURN: v8_7: 23389.83 13:27:25 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,53,35]]", "result": "23389.83"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,53,35]]", "result": "1464.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,53,35]]", "result": "7146.88"}}} 13:27:25 INFO - Return code: 0 13:27:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 13:27:25 INFO - # TBPL SUCCESS # 13:27:25 INFO - Running post-action listener: _resource_record_post_action 13:27:25 INFO - Running post-run listener: _resource_record_post_run 13:27:26 INFO - Total resource usage - Wall time: 1221s; CPU: 13.0%; Read bytes: 335872; Write bytes: 509059072; Read time: 296; Write time: 491188 13:27:26 INFO - install - Wall time: 14s; CPU: 15.0%; Read bytes: 4096; Write bytes: 247123968; Read time: 192; Write time: 359748 13:27:26 INFO - run-tests - Wall time: 1207s; CPU: 13.0%; Read bytes: 331776; Write bytes: 261935104; Read time: 104; Write time: 131440 13:27:26 INFO - Running post-run listener: _upload_blobber_files 13:27:26 INFO - Blob upload gear active. 13:27:26 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 13:27:26 INFO - Copying logs to upload dir... 13:27:26 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1255.525135 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2015-12-28 13:27:25.466691) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-28 13:27:25.471102) ========= 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=3e14eba40af1795cf0357910000001c3-1451332120.524393-171509723 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1451328810/firefox-44.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010019 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1451328810/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-28 13:27:25.525443) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 13:27:25.525772) ========= 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=3e14eba40af1795cf0357910000001c3-1451332120.524393-171509723 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004564 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 13:27:25.576604) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-28 13:27:25.577189) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-28 13:27:25.577696) ========= ========= Total master_lag: 0.23 =========