builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-047 starttime: 1450172553.23 results: success (0) buildid: 20151214205110 builduid: 489f3942ee5c444ea53c5ff4fc03e011 revision: d1a4b331d80b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-15 01:42:33.231737) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-15 01:42:33.232354) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-15 01:42:33.232725) ========= 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=f5f5a079460e1a9be8676904000001c1-1450172538.96931-1797453487 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.005129 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-15 01:42:33.255410) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-15 01:42:33.255732) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-15 01:42:33.288627) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 01:42:33.289001) ========= 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=f5f5a079460e1a9be8676904000001c1-1450172538.96931-1797453487 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004581 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 01:42:33.338638) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-15 01:42:33.339004) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-15 01:42:33.339418) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 01:42:33.339725) ========= 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=f5f5a079460e1a9be8676904000001c1-1450172538.96931-1797453487 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-15 01:42:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 40.3M=0s 2015-12-15 01:42:33 (40.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.166729 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 01:42:33.519691) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 01:42:33.520045) ========= 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=f5f5a079460e1a9be8676904000001c1-1450172538.96931-1797453487 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015716 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 01:42:33.570297) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 01:42:33.570748) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev d1a4b331d80b --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 d1a4b331d80b --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=f5f5a079460e1a9be8676904000001c1-1450172538.96931-1797453487 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-15 01:42:33,911 Setting DEBUG logging. 2015-12-15 01:42:33,911 attempt 1/10 2015-12-15 01:42:33,911 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/d1a4b331d80b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-15 01:42:34,332 unpacking tar archive at: mozilla-beta-d1a4b331d80b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.704612 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 01:42:34.289717) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-15 01:42:34.290052) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-15 01:42:34.300665) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-15 01:42:34.300964) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-15 01:42:34.301398) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2015-12-15 01:42:34.301726) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=f5f5a079460e1a9be8676904000001c1-1450172538.96931-1797453487 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:42:34 INFO - MultiFileLogger online at 20151215 01:42:34 in /builds/slave/test-pgo 01:42:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 01:42:34 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 01:42:34 INFO - {'append_to_log': False, 01:42:34 INFO - 'base_work_dir': '/builds/slave/test-pgo', 01:42:34 INFO - 'blob_upload_branch': 'Mozilla-Beta', 01:42:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 01:42:34 INFO - 'branch': 'Mozilla-Beta', 01:42:34 INFO - 'buildbot_json_path': 'buildprops.json', 01:42:34 INFO - 'config_files': ('talos/linux_config.py',), 01:42:34 INFO - 'default_actions': ('clobber', 01:42:34 INFO - 'read-buildbot-config', 01:42:34 INFO - 'download-and-extract', 01:42:34 INFO - 'populate-webroot', 01:42:34 INFO - 'create-virtualenv', 01:42:34 INFO - 'install', 01:42:34 INFO - 'run-tests'), 01:42:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:42:34 INFO - 'download_minidump_stackwalk': True, 01:42:34 INFO - 'download_symbols': 'ondemand', 01:42:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:42:34 INFO - 'tooltool.py': '/tools/tooltool.py', 01:42:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:42:34 INFO - '/tools/misc-python/virtualenv.py')}, 01:42:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:42:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:42:34 INFO - 'installer_path': 'installer.exe', 01:42:34 INFO - 'log_level': 'info', 01:42:34 INFO - 'log_name': 'talos', 01:42:34 INFO - 'log_to_console': True, 01:42:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:42:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:42:34 INFO - 'opt_config_files': (), 01:42:34 INFO - 'pip_index': False, 01:42:34 INFO - 'sps_profile': False, 01:42:34 INFO - 'sps_profile_interval': 0, 01:42:34 INFO - 'suite': 'dromaeojs', 01:42:34 INFO - 'system_bits': '64', 01:42:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:42:34 INFO - 'title': 'talos-linux64-ix-047', 01:42:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:42:34 INFO - 'use_talos_json': True, 01:42:34 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 01:42:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:42:34 INFO - 'work_dir': 'build'} 01:42:34 INFO - ##### 01:42:34 INFO - ##### Running clobber step. 01:42:34 INFO - ##### 01:42:34 INFO - Running pre-action listener: _resource_record_pre_action 01:42:34 INFO - Running main action method: clobber 01:42:34 INFO - rmtree: /builds/slave/test-pgo/build 01:42:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 01:42:35 INFO - Running post-action listener: _resource_record_post_action 01:42:35 INFO - ##### 01:42:35 INFO - ##### Running read-buildbot-config step. 01:42:35 INFO - ##### 01:42:35 INFO - Running pre-action listener: _resource_record_pre_action 01:42:35 INFO - Running main action method: read_buildbot_config 01:42:35 INFO - Using buildbot properties: 01:42:35 INFO - { 01:42:35 INFO - "properties": { 01:42:35 INFO - "buildnumber": 32, 01:42:35 INFO - "product": "firefox", 01:42:35 INFO - "script_repo_revision": "production", 01:42:35 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 01:42:35 INFO - "repository": "", 01:42:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 01:42:35 INFO - "buildid": "20151214205110", 01:42:35 INFO - "slavename": "talos-linux64-ix-047", 01:42:35 INFO - "pgo_build": "True", 01:42:35 INFO - "basedir": "/builds/slave/test-pgo", 01:42:35 INFO - "project": "", 01:42:35 INFO - "platform": "ubuntu64_hw", 01:42:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 01:42:35 INFO - "slavebuilddir": "test", 01:42:35 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 01:42:35 INFO - "branch": "mozilla-beta", 01:42:35 INFO - "repo_path": "releases/mozilla-beta", 01:42:35 INFO - "stage_platform": "linux64-pgo", 01:42:35 INFO - "builduid": "489f3942ee5c444ea53c5ff4fc03e011", 01:42:35 INFO - "revision": "d1a4b331d80b" 01:42:35 INFO - }, 01:42:35 INFO - "sourcestamp": { 01:42:35 INFO - "repository": "", 01:42:35 INFO - "hasPatch": false, 01:42:35 INFO - "project": "", 01:42:35 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 01:42:35 INFO - "changes": [ 01:42:35 INFO - { 01:42:35 INFO - "category": null, 01:42:35 INFO - "files": [ 01:42:35 INFO - { 01:42:35 INFO - "url": null, 01:42:35 INFO - "name": "http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450155070/firefox-44.0.en-US.linux-x86_64.tar.bz2" 01:42:35 INFO - } 01:42:35 INFO - ], 01:42:35 INFO - "repository": "", 01:42:35 INFO - "rev": "d1a4b331d80b", 01:42:35 INFO - "who": "sendchange", 01:42:35 INFO - "when": 1450172539, 01:42:35 INFO - "number": 7361409, 01:42:35 INFO - "comments": "Bug 1232466 - Hack around use of re.sub(..., flags=). r=me a=bustage", 01:42:35 INFO - "project": "", 01:42:35 INFO - "at": "Tue 15 Dec 2015 01:42:19", 01:42:35 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 01:42:35 INFO - "revlink": "", 01:42:35 INFO - "properties": [ 01:42:35 INFO - [ 01:42:35 INFO - "buildid", 01:42:35 INFO - "20151214205110", 01:42:35 INFO - "Change" 01:42:35 INFO - ], 01:42:35 INFO - [ 01:42:35 INFO - "builduid", 01:42:35 INFO - "489f3942ee5c444ea53c5ff4fc03e011", 01:42:35 INFO - "Change" 01:42:35 INFO - ], 01:42:35 INFO - [ 01:42:35 INFO - "pgo_build", 01:42:35 INFO - "True", 01:42:35 INFO - "Change" 01:42:35 INFO - ] 01:42:35 INFO - ], 01:42:35 INFO - "revision": "d1a4b331d80b" 01:42:35 INFO - } 01:42:35 INFO - ], 01:42:35 INFO - "revision": "d1a4b331d80b" 01:42:35 INFO - } 01:42:35 INFO - } 01:42:35 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450155070/firefox-44.0.en-US.linux-x86_64.tar.bz2. 01:42:35 INFO - Running post-action listener: _resource_record_post_action 01:42:35 INFO - ##### 01:42:35 INFO - ##### Running download-and-extract step. 01:42:35 INFO - ##### 01:42:35 INFO - Running pre-action listener: _resource_record_pre_action 01:42:35 INFO - Running main action method: download_and_extract 01:42:35 INFO - mkdir: /builds/slave/test-pgo/build/tests 01:42: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')]} 01:42:35 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450155070/test_packages.json 01:42:35 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450155070/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 01:42:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450155070/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 01:42:35 INFO - Downloaded 1270 bytes. 01:42:35 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 01:42:35 INFO - Using the following test package requirements: 01:42:35 INFO - {u'common': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip'], 01:42:35 INFO - u'cppunittest': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 01:42:35 INFO - u'firefox-44.0.en-US.linux-x86_64.cppunittest.tests.zip'], 01:42:35 INFO - u'jittest': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 01:42:35 INFO - u'jsshell-linux-x86_64.zip'], 01:42:35 INFO - u'mochitest': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 01:42:35 INFO - u'firefox-44.0.en-US.linux-x86_64.mochitest.tests.zip'], 01:42:35 INFO - u'mozbase': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip'], 01:42:35 INFO - u'reftest': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 01:42:35 INFO - u'firefox-44.0.en-US.linux-x86_64.reftest.tests.zip'], 01:42:35 INFO - u'talos': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 01:42:35 INFO - u'firefox-44.0.en-US.linux-x86_64.talos.tests.zip'], 01:42:35 INFO - u'web-platform': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 01:42:35 INFO - u'firefox-44.0.en-US.linux-x86_64.web-platform.tests.zip'], 01:42:35 INFO - u'webapprt': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip'], 01:42:35 INFO - u'xpcshell': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 01:42:35 INFO - u'firefox-44.0.en-US.linux-x86_64.xpcshell.tests.zip']} 01:42:35 INFO - Downloading packages: [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:42: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')]} 01:42:35 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450155070/firefox-44.0.en-US.linux-x86_64.common.tests.zip 01:42:35 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450155070/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 01:42:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450155070/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 01:42:35 INFO - Downloaded 22571345 bytes. 01:42:35 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 01:42:35 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip 01:42:35 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 01:42:36 INFO - Return code: 0 01:42:36 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 01:42:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:42:36 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450155070/firefox-44.0.en-US.linux-x86_64.common.tests.zip 01:42:36 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450155070/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 01:42:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450155070/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 01:42:37 INFO - Downloaded 22571345 bytes. 01:42:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 01:42:37 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip 01:42:37 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 01:42:38 INFO - Return code: 0 01:42: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')]} 01:42:38 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450155070/firefox-44.0.en-US.linux-x86_64.talos.tests.zip 01:42:38 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450155070/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 01:42:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450155070/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 01:42:38 INFO - Downloaded 11131970 bytes. 01:42:38 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 01:42:38 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.talos.tests.zip 01:42:38 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 01:42:38 INFO - Return code: 0 01:42: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')]} 01:42:38 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450155070/firefox-44.0.en-US.linux-x86_64.tar.bz2 01:42:38 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450155070/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 01:42:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450155070/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 01:42:39 INFO - Downloaded 56636614 bytes. 01:42:39 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450155070/firefox-44.0.en-US.linux-x86_64.tar.bz2 01:42:39 INFO - mkdir: /builds/slave/test-pgo/properties 01:42:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 01:42:39 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 01:42:39 INFO - Contents: 01:42:39 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450155070/firefox-44.0.en-US.linux-x86_64.tar.bz2 01:42:39 INFO - Running post-action listener: _resource_record_post_action 01:42:39 INFO - Running post-action listener: set_extra_try_arguments 01:42:39 INFO - ##### 01:42:39 INFO - ##### Running populate-webroot step. 01:42:39 INFO - ##### 01:42:39 INFO - Running pre-action listener: _resource_record_pre_action 01:42:39 INFO - Running main action method: populate_webroot 01:42:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:42:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:42:39 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 01:42:39 INFO - '../fennec_ids.txt'], 01:42:39 INFO - 'tests': ['tcheck2']}, 01:42:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:42:39 INFO - '--tppagecycles', 01:42:39 INFO - '7'], 01:42:39 INFO - 'tests': ['tsvgm']}}, 01:42:39 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 01:42:39 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 01:42:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:42:39 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:42:39 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 01:42:39 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:42:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:42:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:42:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:42:39 INFO - 'talos_options': ['--e10s'], 01:42:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:42:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:42:39 INFO - 'tests': ['damp', 'tps']}, 01:42:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:42:39 INFO - 'talos_options': ['--e10s'], 01:42:39 INFO - 'tests': ['damp', 'tps']}, 01:42:39 INFO - 'g3': {'tests': ['dromaeo_dom']}, 01:42:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:42:39 INFO - 'other': {'tests': ['a11yr', 01:42:39 INFO - 'ts_paint', 01:42:39 INFO - 'tpaint', 01:42:39 INFO - 'sessionrestore', 01:42:39 INFO - 'sessionrestore_no_auto_restore']}, 01:42:39 INFO - 'other-e10s': {'talos_options': ['--e10s'], 01:42:39 INFO - 'tests': ['a11yr', 01:42:39 INFO - 'ts_paint', 01:42:39 INFO - 'tpaint', 01:42:39 INFO - 'sessionrestore', 01:42:39 INFO - 'sessionrestore_no_auto_restore']}, 01:42:39 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 01:42:39 INFO - 'tests': ['a11yr', 01:42:39 INFO - 'ts_paint', 01:42:39 INFO - 'tpaint', 01:42:39 INFO - 'sessionrestore', 01:42:39 INFO - 'sessionrestore_no_auto_restore']}, 01:42:39 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 01:42:39 INFO - 'tests': ['a11yr', 01:42:39 INFO - 'ts_paint', 01:42:39 INFO - 'tpaint', 01:42:39 INFO - 'sessionrestore', 01:42:39 INFO - 'sessionrestore_no_auto_restore']}, 01:42:39 INFO - 'other_l64': {'tests': ['a11yr', 01:42:39 INFO - 'ts_paint', 01:42:39 INFO - 'tpaint', 01:42:39 INFO - 'sessionrestore', 01:42:39 INFO - 'sessionrestore_no_auto_restore']}, 01:42:39 INFO - 'other_nol64': {'tests': ['a11yr', 01:42:39 INFO - 'ts_paint', 01:42:39 INFO - 'tpaint', 01:42:39 INFO - 'sessionrestore', 01:42:39 INFO - 'sessionrestore_no_auto_restore']}, 01:42:39 INFO - 'svgr': {'tests': ['tsvgx', 01:42:39 INFO - 'tsvgr_opacity', 01:42:39 INFO - 'tart', 01:42:39 INFO - 'tscrollx', 01:42:39 INFO - 'cart']}, 01:42:39 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 01:42:39 INFO - 'tests': ['tsvgx', 01:42:39 INFO - 'tsvgr_opacity', 01:42:39 INFO - 'tart', 01:42:39 INFO - 'tscrollx', 01:42:39 INFO - 'cart']}, 01:42:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:42:39 INFO - 'tests': ['tp5o']}, 01:42:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:42:39 INFO - 'talos_options': ['--e10s'], 01:42:39 INFO - 'tests': ['tp5o']}, 01:42:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:42:39 INFO - 'talos_options': ['--xperf_path', 01:42:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:42:39 INFO - 'tests': ['tp5n']}, 01:42:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:42:39 INFO - 'talos_options': ['--e10s', 01:42:39 INFO - '--xperf_path', 01:42:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:42:39 INFO - 'tests': ['tp5n']}}, 01:42:39 INFO - 'talos.zip': {'path': '', 01:42:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:42:39 INFO - Running post-action listener: _resource_record_post_action 01:42:39 INFO - ##### 01:42:39 INFO - ##### Running create-virtualenv step. 01:42:39 INFO - ##### 01:42:39 INFO - Running pre-action listener: _resource_record_pre_action 01:42:39 INFO - Running main action method: create_virtualenv 01:42:39 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 01:42:39 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 01:42:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 01:42:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:42:39 INFO - Using real prefix '/usr' 01:42:39 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 01:42:40 INFO - Installing distribute.............................................................................................................................................................................................done. 01:42:42 INFO - Installing pip.................done. 01:42:42 INFO - Return code: 0 01:42:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 01:42:42 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')]} 01:42:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:42:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:42:42 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')]} 01:42:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:42:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:42:42 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 0x7f53034fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x185f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x192c600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19bb350>, '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 0x19bc250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19bc6e0>, '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': 'f5f5a079460e1a9be8676904000001c1-1450172538.96931-1797453487', '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 01:42:42 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 01:42:42 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 01:42:42 INFO - Using env: {'DISPLAY': ':0', 01:42:42 INFO - 'HOME': '/home/cltbld', 01:42:42 INFO - 'LANG': 'en_US.UTF-8', 01:42:42 INFO - 'LANGUAGE': 'en_US:en', 01:42:42 INFO - 'LOGNAME': 'cltbld', 01:42:42 INFO - 'MAIL': '/var/mail/cltbld', 01:42:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:42:42 INFO - 'MOZ_NO_REMOTE': '1', 01:42:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:42:42 INFO - 'NO_EM_RESTART': '1', 01:42:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:42:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:42:42 INFO - 'PWD': '/builds/slave/test-pgo', 01:42:42 INFO - 'SHELL': '/bin/bash', 01:42:42 INFO - 'SHLVL': '1', 01:42:42 INFO - 'TERM': 'linux', 01:42:42 INFO - 'TMOUT': '86400', 01:42:42 INFO - 'USER': 'cltbld', 01:42:42 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1450172538.96931-1797453487', 01:42:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:42:42 INFO - '_': '/tools/buildbot/bin/python'} 01:42:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:42:42 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 01:42:42 INFO - Cleaning up... 01:42:42 INFO - Return code: 0 01:42:42 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 01:42:42 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')]} 01:42:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:42:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:42:42 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')]} 01:42:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:42:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:42:42 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 0x7f53034fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x185f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x192c600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19bb350>, '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 0x19bc250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19bc6e0>, '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': 'f5f5a079460e1a9be8676904000001c1-1450172538.96931-1797453487', '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 01:42:42 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 01:42:42 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 01:42:42 INFO - Using env: {'DISPLAY': ':0', 01:42:42 INFO - 'HOME': '/home/cltbld', 01:42:42 INFO - 'LANG': 'en_US.UTF-8', 01:42:42 INFO - 'LANGUAGE': 'en_US:en', 01:42:42 INFO - 'LOGNAME': 'cltbld', 01:42:42 INFO - 'MAIL': '/var/mail/cltbld', 01:42:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:42:42 INFO - 'MOZ_NO_REMOTE': '1', 01:42:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:42:42 INFO - 'NO_EM_RESTART': '1', 01:42:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:42:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:42:42 INFO - 'PWD': '/builds/slave/test-pgo', 01:42:42 INFO - 'SHELL': '/bin/bash', 01:42:42 INFO - 'SHLVL': '1', 01:42:42 INFO - 'TERM': 'linux', 01:42:42 INFO - 'TMOUT': '86400', 01:42:42 INFO - 'USER': 'cltbld', 01:42:42 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1450172538.96931-1797453487', 01:42:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:42:42 INFO - '_': '/tools/buildbot/bin/python'} 01:42:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:42:42 INFO - Downloading/unpacking psutil>=0.7.1 01:42:42 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 01:42:42 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 01:42:42 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 01:42:42 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 01:42:42 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 01:42:42 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 01:42:44 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 01:42:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 01:42:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 01:42:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:42:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:42:44 INFO - Installing collected packages: psutil 01:42:44 INFO - Running setup.py install for psutil 01:42:44 INFO - building 'psutil._psutil_linux' extension 01:42:44 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 01:42:44 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 01:42:44 INFO - building 'psutil._psutil_posix' extension 01:42:44 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 01:42:44 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 01:42:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:42:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:42:44 INFO - Successfully installed psutil 01:42:44 INFO - Cleaning up... 01:42:44 INFO - Return code: 0 01:42:44 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 01:42:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:42:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:42:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:42:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:42:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:42:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:42:44 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 0x7f53034fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x185f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x192c600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19bb350>, '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 0x19bc250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19bc6e0>, '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': 'f5f5a079460e1a9be8676904000001c1-1450172538.96931-1797453487', '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 01:42:44 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 01:42:44 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 01:42:44 INFO - Using env: {'DISPLAY': ':0', 01:42:44 INFO - 'HOME': '/home/cltbld', 01:42:44 INFO - 'LANG': 'en_US.UTF-8', 01:42:44 INFO - 'LANGUAGE': 'en_US:en', 01:42:44 INFO - 'LOGNAME': 'cltbld', 01:42:44 INFO - 'MAIL': '/var/mail/cltbld', 01:42:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:42:44 INFO - 'MOZ_NO_REMOTE': '1', 01:42:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:42:44 INFO - 'NO_EM_RESTART': '1', 01:42:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:42:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:42:44 INFO - 'PWD': '/builds/slave/test-pgo', 01:42:44 INFO - 'SHELL': '/bin/bash', 01:42:44 INFO - 'SHLVL': '1', 01:42:44 INFO - 'TERM': 'linux', 01:42:44 INFO - 'TMOUT': '86400', 01:42:44 INFO - 'USER': 'cltbld', 01:42:44 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1450172538.96931-1797453487', 01:42:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:42:44 INFO - '_': '/tools/buildbot/bin/python'} 01:42:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:42:45 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:42:45 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 01:42:45 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 01:42:45 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 01:42:45 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 01:42:45 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 01:42:45 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 01:42:46 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:42:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 01:42:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:42:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:42:46 INFO - Installing collected packages: mozsystemmonitor 01:42:46 INFO - Running setup.py install for mozsystemmonitor 01:42:46 INFO - Successfully installed mozsystemmonitor 01:42:46 INFO - Cleaning up... 01:42:47 INFO - Return code: 0 01:42:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 01:42:47 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')]} 01:42:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:42:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:42:47 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')]} 01:42:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:42:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:42:47 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 0x7f53034fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x185f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x192c600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19bb350>, '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 0x19bc250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19bc6e0>, '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': 'f5f5a079460e1a9be8676904000001c1-1450172538.96931-1797453487', '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 01:42:47 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 01:42:47 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 01:42:47 INFO - Using env: {'DISPLAY': ':0', 01:42:47 INFO - 'HOME': '/home/cltbld', 01:42:47 INFO - 'LANG': 'en_US.UTF-8', 01:42:47 INFO - 'LANGUAGE': 'en_US:en', 01:42:47 INFO - 'LOGNAME': 'cltbld', 01:42:47 INFO - 'MAIL': '/var/mail/cltbld', 01:42:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:42:47 INFO - 'MOZ_NO_REMOTE': '1', 01:42:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:42:47 INFO - 'NO_EM_RESTART': '1', 01:42:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:42:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:42:47 INFO - 'PWD': '/builds/slave/test-pgo', 01:42:47 INFO - 'SHELL': '/bin/bash', 01:42:47 INFO - 'SHLVL': '1', 01:42:47 INFO - 'TERM': 'linux', 01:42:47 INFO - 'TMOUT': '86400', 01:42:47 INFO - 'USER': 'cltbld', 01:42:47 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1450172538.96931-1797453487', 01:42:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:42:47 INFO - '_': '/tools/buildbot/bin/python'} 01:42:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:42:47 INFO - Downloading/unpacking blobuploader==1.2.4 01:42:47 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 01:42:47 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 01:42:47 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 01:42:47 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 01:42:47 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 01:42:47 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 01:42:49 INFO - Downloading blobuploader-1.2.4.tar.gz 01:42:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 01:42:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:42:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:42:49 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 01:42:49 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 01:42:49 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 01:42:49 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 01:42:49 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 01:42:49 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 01:42:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 01:42:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 01:42:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:42:49 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 01:42:49 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 01:42:49 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 01:42:49 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 01:42:49 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 01:42:49 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 01:42:49 INFO - Downloading docopt-0.6.1.tar.gz 01:42:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 01:42:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 01:42:49 INFO - Installing collected packages: blobuploader, requests, docopt 01:42:49 INFO - Running setup.py install for blobuploader 01:42:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:42:49 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 01:42:49 INFO - Running setup.py install for requests 01:42:50 INFO - Running setup.py install for docopt 01:42:50 INFO - Successfully installed blobuploader requests docopt 01:42:50 INFO - Cleaning up... 01:42:50 INFO - Return code: 0 01:42:50 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:42:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:42:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:42:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:42:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:42:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:42:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:42:50 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 0x7f53034fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x185f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x192c600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19bb350>, '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 0x19bc250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19bc6e0>, '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': 'f5f5a079460e1a9be8676904000001c1-1450172538.96931-1797453487', '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 01:42:50 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 01:42:50 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 01:42:50 INFO - Using env: {'DISPLAY': ':0', 01:42:50 INFO - 'HOME': '/home/cltbld', 01:42:50 INFO - 'LANG': 'en_US.UTF-8', 01:42:50 INFO - 'LANGUAGE': 'en_US:en', 01:42:50 INFO - 'LOGNAME': 'cltbld', 01:42:50 INFO - 'MAIL': '/var/mail/cltbld', 01:42:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:42:50 INFO - 'MOZ_NO_REMOTE': '1', 01:42:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:42:50 INFO - 'NO_EM_RESTART': '1', 01:42:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:42:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:42:50 INFO - 'PWD': '/builds/slave/test-pgo', 01:42:50 INFO - 'SHELL': '/bin/bash', 01:42:50 INFO - 'SHLVL': '1', 01:42:50 INFO - 'TERM': 'linux', 01:42:50 INFO - 'TMOUT': '86400', 01:42:50 INFO - 'USER': 'cltbld', 01:42:50 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1450172538.96931-1797453487', 01:42:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:42:50 INFO - '_': '/tools/buildbot/bin/python'} 01:42:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:42:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:42:50 INFO - Running setup.py (path:/tmp/pip-mXeoGU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:42:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:42:50 INFO - Running setup.py (path:/tmp/pip-klZ4uI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:42:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:42:50 INFO - Running setup.py (path:/tmp/pip-vkzjVU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:42:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:42:50 INFO - Running setup.py (path:/tmp/pip-bJltDb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:42:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 01:42:50 INFO - Running setup.py (path:/tmp/pip-iWVoyy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 01:42:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:42:50 INFO - Running setup.py (path:/tmp/pip-maKLLv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:42:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:42:51 INFO - Running setup.py (path:/tmp/pip-teVHpi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:42:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:42:51 INFO - Running setup.py (path:/tmp/pip-RC9BiN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:42:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 01:42:51 INFO - Running setup.py (path:/tmp/pip-hjXlxR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 01:42:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 01:42:51 INFO - Running setup.py (path:/tmp/pip-9G20iw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 01:42:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:42:51 INFO - Running setup.py (path:/tmp/pip-TPOBOj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:42:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:42:51 INFO - Running setup.py (path:/tmp/pip-dXJOne-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:42:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:42:51 INFO - Running setup.py (path:/tmp/pip-ySJHdw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:42:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:42:51 INFO - Running setup.py (path:/tmp/pip-7TRROy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:42:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:42:51 INFO - Running setup.py (path:/tmp/pip-pw0XXX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:42:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 01:42:51 INFO - Running setup.py (path:/tmp/pip-IzesOC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 01:42:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 01:42:51 INFO - Running setup.py (path:/tmp/pip-mAbU1l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 01:42:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:42:51 INFO - Running setup.py install for manifestparser 01:42:51 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 01:42:51 INFO - Running setup.py install for mozcrash 01:42:52 INFO - Running setup.py install for mozdebug 01:42:52 INFO - Running setup.py install for mozdevice 01:42:52 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 01:42:52 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 01:42:52 INFO - Running setup.py install for mozfile 01:42:52 INFO - Running setup.py install for mozhttpd 01:42:52 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 01:42:52 INFO - Running setup.py install for mozinfo 01:42:52 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 01:42:52 INFO - Running setup.py install for mozInstall 01:42:52 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 01:42:52 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 01:42:52 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 01:42:52 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 01:42:52 INFO - Running setup.py install for mozleak 01:42:52 INFO - Running setup.py install for mozlog 01:42:52 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 01:42:52 INFO - Running setup.py install for moznetwork 01:42:52 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 01:42:52 INFO - Running setup.py install for mozprocess 01:42:53 INFO - Running setup.py install for mozprofile 01:42:53 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 01:42:53 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 01:42:53 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 01:42:53 INFO - Running setup.py install for mozrunner 01:42:53 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 01:42:53 INFO - Running setup.py install for mozscreenshot 01:42:53 INFO - Running setup.py install for moztest 01:42:53 INFO - Running setup.py install for mozversion 01:42:53 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 01:42:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:42:53 INFO - Cleaning up... 01:42:53 INFO - Return code: 0 01:42:53 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:42:53 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')]} 01:42:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:42:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:42:53 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')]} 01:42:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:42:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:42:53 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 0x7f53034fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x185f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x192c600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19bb350>, '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 0x19bc250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19bc6e0>, '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': 'f5f5a079460e1a9be8676904000001c1-1450172538.96931-1797453487', '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 01:42:53 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 01:42:53 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 01:42:53 INFO - Using env: {'DISPLAY': ':0', 01:42:53 INFO - 'HOME': '/home/cltbld', 01:42:53 INFO - 'LANG': 'en_US.UTF-8', 01:42:53 INFO - 'LANGUAGE': 'en_US:en', 01:42:53 INFO - 'LOGNAME': 'cltbld', 01:42:53 INFO - 'MAIL': '/var/mail/cltbld', 01:42:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:42:53 INFO - 'MOZ_NO_REMOTE': '1', 01:42:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:42:53 INFO - 'NO_EM_RESTART': '1', 01:42:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:42:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:42:53 INFO - 'PWD': '/builds/slave/test-pgo', 01:42:53 INFO - 'SHELL': '/bin/bash', 01:42:53 INFO - 'SHLVL': '1', 01:42:53 INFO - 'TERM': 'linux', 01:42:53 INFO - 'TMOUT': '86400', 01:42:53 INFO - 'USER': 'cltbld', 01:42:53 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1450172538.96931-1797453487', 01:42:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:42:53 INFO - '_': '/tools/buildbot/bin/python'} 01:42:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:42:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:42:53 INFO - Running setup.py (path:/tmp/pip-muqNeF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:42:53 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)) 01:42:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:42:53 INFO - Running setup.py (path:/tmp/pip-7LTuZa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:42:53 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)) 01:42:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:42:53 INFO - Running setup.py (path:/tmp/pip-FrbRiJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:42:54 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)) 01:42:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:42:54 INFO - Running setup.py (path:/tmp/pip-5ibKVF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:42:54 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)) 01:42:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 01:42:54 INFO - Running setup.py (path:/tmp/pip-C61Mah-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 01:42:54 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)) 01:42:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:42:54 INFO - Running setup.py (path:/tmp/pip-zrMdRa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:42:54 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)) 01:42:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:42:54 INFO - Running setup.py (path:/tmp/pip-bYYrPe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:42:54 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)) 01:42:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:42:54 INFO - Running setup.py (path:/tmp/pip-UqxbjO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:42:54 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)) 01:42:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 01:42:54 INFO - Running setup.py (path:/tmp/pip-Klkkc7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 01:42:54 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)) 01:42:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 01:42:54 INFO - Running setup.py (path:/tmp/pip-wXSPkg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 01:42:54 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)) 01:42:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:42:54 INFO - Running setup.py (path:/tmp/pip-Xe7KoQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:42:54 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)) 01:42:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:42:54 INFO - Running setup.py (path:/tmp/pip-Pmzf7P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:42:54 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)) 01:42:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:42:54 INFO - Running setup.py (path:/tmp/pip-2BjPKS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:42:54 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)) 01:42:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:42:54 INFO - Running setup.py (path:/tmp/pip-K4q5eT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:42:54 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)) 01:42:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:42:54 INFO - Running setup.py (path:/tmp/pip-cO3j77-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:42:54 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)) 01:42:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 01:42:54 INFO - Running setup.py (path:/tmp/pip-k5Hb9z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 01:42:54 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)) 01:42:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 01:42:54 INFO - Running setup.py (path:/tmp/pip-35yW7C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 01:42:55 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)) 01:42:55 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)) 01:42:55 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)) 01:42:55 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)) 01:42:55 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)) 01:42:55 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)) 01:42:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 01:42:55 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 01:42:55 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 01:42:55 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 01:42:55 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 01:42:55 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 01:42:55 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 01:42:56 INFO - Downloading blessings-1.5.1.tar.gz 01:42:56 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 01:42:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 01:42:56 INFO - Installing collected packages: blessings 01:42:56 INFO - Running setup.py install for blessings 01:42:56 INFO - Successfully installed blessings 01:42:56 INFO - Cleaning up... 01:42:56 INFO - Return code: 0 01:42:56 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 01:42:56 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 01:42:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 01:42:57 INFO - Reading from file tmpfile_stdout 01:42:57 INFO - Current package versions: 01:42:57 INFO - argparse == 1.2.1 01:42:57 INFO - blessings == 1.5.1 01:42:57 INFO - blobuploader == 1.2.4 01:42:57 INFO - docopt == 0.6.1 01:42:57 INFO - manifestparser == 1.1 01:42:57 INFO - mozInstall == 1.12 01:42:57 INFO - mozcrash == 0.16 01:42:57 INFO - mozdebug == 0.1 01:42:57 INFO - mozdevice == 0.46 01:42:57 INFO - mozfile == 1.2 01:42:57 INFO - mozhttpd == 0.7 01:42:57 INFO - mozinfo == 0.8 01:42:57 INFO - mozleak == 0.1 01:42:57 INFO - mozlog == 3.0 01:42:57 INFO - moznetwork == 0.27 01:42:57 INFO - mozprocess == 0.22 01:42:57 INFO - mozprofile == 0.27 01:42:57 INFO - mozrunner == 6.11 01:42:57 INFO - mozscreenshot == 0.1 01:42:57 INFO - mozsystemmonitor == 0.0 01:42:57 INFO - moztest == 0.7 01:42:57 INFO - mozversion == 1.4 01:42:57 INFO - psutil == 3.1.1 01:42:57 INFO - requests == 1.2.3 01:42:57 INFO - wsgiref == 0.1.2 01:42:57 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:42:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:42:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:42:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:42:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:42:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:42:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:42:57 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 0x7f53034fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x185f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x192c600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19bb350>, '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 0x19bc250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19bc6e0>, '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': 'f5f5a079460e1a9be8676904000001c1-1450172538.96931-1797453487', '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 01:42:57 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 01:42:57 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 01:42:57 INFO - Using env: {'DISPLAY': ':0', 01:42:57 INFO - 'HOME': '/home/cltbld', 01:42:57 INFO - 'LANG': 'en_US.UTF-8', 01:42:57 INFO - 'LANGUAGE': 'en_US:en', 01:42:57 INFO - 'LOGNAME': 'cltbld', 01:42:57 INFO - 'MAIL': '/var/mail/cltbld', 01:42:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:42:57 INFO - 'MOZ_NO_REMOTE': '1', 01:42:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:42:57 INFO - 'NO_EM_RESTART': '1', 01:42:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:42:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:42:57 INFO - 'PWD': '/builds/slave/test-pgo', 01:42:57 INFO - 'SHELL': '/bin/bash', 01:42:57 INFO - 'SHLVL': '1', 01:42:57 INFO - 'TERM': 'linux', 01:42:57 INFO - 'TMOUT': '86400', 01:42:57 INFO - 'USER': 'cltbld', 01:42:57 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1450172538.96931-1797453487', 01:42:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:42:57 INFO - '_': '/tools/buildbot/bin/python'} 01:42:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:42:57 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)) 01:42:57 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)) 01:42:57 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)) 01:42:57 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)) 01:42:57 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)) 01:42:57 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)) 01:42:57 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)) 01:42:57 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)) 01:42:57 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)) 01:42:57 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)) 01:42:57 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)) 01:42:57 INFO - Cleaning up... 01:42:57 INFO - Return code: 0 01:42:57 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 01:42:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:42:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:42:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:42:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:42:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:42:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:42:57 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 0x7f53034fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x185f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x192c600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19bb350>, '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 0x19bc250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19bc6e0>, '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': 'f5f5a079460e1a9be8676904000001c1-1450172538.96931-1797453487', '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 01:42:57 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 01:42:57 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 01:42:57 INFO - Using env: {'DISPLAY': ':0', 01:42:57 INFO - 'HOME': '/home/cltbld', 01:42:57 INFO - 'LANG': 'en_US.UTF-8', 01:42:57 INFO - 'LANGUAGE': 'en_US:en', 01:42:57 INFO - 'LOGNAME': 'cltbld', 01:42:57 INFO - 'MAIL': '/var/mail/cltbld', 01:42:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:42:57 INFO - 'MOZ_NO_REMOTE': '1', 01:42:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:42:57 INFO - 'NO_EM_RESTART': '1', 01:42:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:42:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:42:57 INFO - 'PWD': '/builds/slave/test-pgo', 01:42:57 INFO - 'SHELL': '/bin/bash', 01:42:57 INFO - 'SHLVL': '1', 01:42:57 INFO - 'TERM': 'linux', 01:42:57 INFO - 'TMOUT': '86400', 01:42:57 INFO - 'USER': 'cltbld', 01:42:57 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1450172538.96931-1797453487', 01:42:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:42:57 INFO - '_': '/tools/buildbot/bin/python'} 01:42:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:42:57 INFO - Downloading/unpacking jsonschema 01:42:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:42:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:42:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:42:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:42:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:42:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:42:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:42:59 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 01:42:59 INFO - Downloading/unpacking functools32 (from jsonschema) 01:42:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:42:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:42:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:42:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:42:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:42:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:42:59 INFO - Downloading functools32-3.2.3-2.tar.gz 01:42:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 01:42:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 01:42:59 INFO - warning: no files found matching '*.txt' 01:42:59 INFO - no previously-included directories found matching 'build' 01:42:59 INFO - no previously-included directories found matching 'dist' 01:42:59 INFO - no previously-included directories found matching '.git*' 01:42:59 INFO - Installing collected packages: jsonschema, functools32 01:42:59 INFO - Running setup.py install for functools32 01:42:59 INFO - warning: no files found matching '*.txt' 01:42:59 INFO - no previously-included directories found matching 'build' 01:42:59 INFO - no previously-included directories found matching 'dist' 01:42:59 INFO - no previously-included directories found matching '.git*' 01:42:59 INFO - Successfully installed jsonschema functools32 01:42:59 INFO - Cleaning up... 01:42:59 INFO - Return code: 0 01:42:59 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 01:42:59 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')]} 01:42:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:42:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:42:59 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')]} 01:42:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:42:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:42:59 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 0x7f53034fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x185f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x192c600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19bb350>, '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 0x19bc250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19bc6e0>, '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': 'f5f5a079460e1a9be8676904000001c1-1450172538.96931-1797453487', '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 01:42:59 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 01:42:59 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 01:42:59 INFO - Using env: {'DISPLAY': ':0', 01:42:59 INFO - 'HOME': '/home/cltbld', 01:42:59 INFO - 'LANG': 'en_US.UTF-8', 01:42:59 INFO - 'LANGUAGE': 'en_US:en', 01:42:59 INFO - 'LOGNAME': 'cltbld', 01:42:59 INFO - 'MAIL': '/var/mail/cltbld', 01:42:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:42:59 INFO - 'MOZ_NO_REMOTE': '1', 01:42:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:42:59 INFO - 'NO_EM_RESTART': '1', 01:42:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:42:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:42:59 INFO - 'PWD': '/builds/slave/test-pgo', 01:42:59 INFO - 'SHELL': '/bin/bash', 01:42:59 INFO - 'SHLVL': '1', 01:42:59 INFO - 'TERM': 'linux', 01:42:59 INFO - 'TMOUT': '86400', 01:42:59 INFO - 'USER': 'cltbld', 01:42:59 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1450172538.96931-1797453487', 01:42:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:42:59 INFO - '_': '/tools/buildbot/bin/python'} 01:42:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:42:59 INFO - Downloading/unpacking flake8 01:42:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:42:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:42:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:42:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:42:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:42:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:43:01 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:43:01 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 01:43:01 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:43: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 01:43: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 01:43: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 01:43: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 01:43: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 01:43: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 01:43:01 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:43:01 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 01:43:01 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:43: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 01:43: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 01:43: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 01:43: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 01:43: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 01:43: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 01:43:02 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 01:43:02 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:43: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 01:43: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 01:43: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 01:43: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 01:43: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 01:43: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 01:43:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 01:43:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 01:43:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:43:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:43:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:43:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:43:02 INFO - no previously-included directories found matching 'docs/_build' 01:43:02 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:43:02 INFO - Running setup.py install for pep8 01:43:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:43:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:43:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:43:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:43:02 INFO - no previously-included directories found matching 'docs/_build' 01:43:02 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 01:43:02 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:43:02 INFO - Cleaning up... 01:43:02 INFO - Return code: 0 01:43:02 INFO - Running post-action listener: _resource_record_post_action 01:43:02 INFO - Running post-action listener: _start_resource_monitoring 01:43:02 INFO - Starting resource monitoring. 01:43:02 INFO - ##### 01:43:02 INFO - ##### Running install step. 01:43:02 INFO - ##### 01:43:02 INFO - Running pre-action listener: _resource_record_pre_action 01:43:02 INFO - Running main action method: install 01:43:02 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 01:43:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 01:43:02 INFO - Reading from file tmpfile_stdout 01:43:02 INFO - Detecting whether we're running mozinstall >=1.0... 01:43:02 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 01:43:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 01:43:02 INFO - Reading from file tmpfile_stdout 01:43:02 INFO - Output received: 01:43:02 INFO - Usage: mozinstall [options] installer 01:43:02 INFO - Options: 01:43:02 INFO - -h, --help show this help message and exit 01:43:02 INFO - -d DEST, --destination=DEST 01:43:02 INFO - Directory to install application into. [default: 01:43:02 INFO - "/builds/slave/test-pgo"] 01:43:02 INFO - --app=APP Application being installed. [default: firefox] 01:43:02 INFO - mkdir: /builds/slave/test-pgo/build/application 01:43:02 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'] 01:43:02 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 01:43:17 INFO - Reading from file tmpfile_stdout 01:43:17 INFO - Output received: 01:43:17 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 01:43:17 INFO - Running post-action listener: _resource_record_post_action 01:43:17 INFO - ##### 01:43:17 INFO - ##### Running run-tests step. 01:43:17 INFO - ##### 01:43:17 INFO - Running pre-action listener: _resource_record_pre_action 01:43:17 INFO - Running main action method: run_tests 01:43:17 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 01:43:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 01:43:17 INFO - Python 2.7.3 01:43:17 INFO - Return code: 0 01:43:17 INFO - grabbing minidump binary from tooltool 01:43:17 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')]} 01:43:17 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 0x19bb350>, '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 0x19bc250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19bc6e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 01:43:17 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 01:43:17 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 01:43:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:43:17 INFO - Return code: 0 01:43:17 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 01:43:17 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 01:43:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 01:43:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 01:43:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 01:43:17 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 01:43:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 01:43:18 INFO - Return code: 0 01:43:18 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/1450155070/firefox-44.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 01:43:18 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/1450155070/firefox-44.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --webServer localhost 01:43:18 INFO - Using env: {'DISPLAY': ':0', 01:43:18 INFO - 'HOME': '/home/cltbld', 01:43:18 INFO - 'LANG': 'en_US.UTF-8', 01:43:18 INFO - 'LANGUAGE': 'en_US:en', 01:43:18 INFO - 'LOGNAME': 'cltbld', 01:43:18 INFO - 'MAIL': '/var/mail/cltbld', 01:43:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 01:43:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 01:43:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:43:18 INFO - 'MOZ_NO_REMOTE': '1', 01:43:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 01:43:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:43:18 INFO - 'NO_EM_RESTART': '1', 01:43:18 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:43:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:43:18 INFO - 'PWD': '/builds/slave/test-pgo', 01:43:18 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 01:43:18 INFO - 'SHELL': '/bin/bash', 01:43:18 INFO - 'SHLVL': '1', 01:43:18 INFO - 'TERM': 'linux', 01:43:18 INFO - 'TMOUT': '86400', 01:43:18 INFO - 'USER': 'cltbld', 01:43:18 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1450172538.96931-1797453487', 01:43:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:43:18 INFO - '_': '/tools/buildbot/bin/python'} 01:43:18 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/1450155070/firefox-44.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost'] with output_timeout 3600 01:43:18 INFO - mozversion INFO | application_buildid: 20151214205110 01:43:18 INFO - mozversion INFO | application_changeset: d1a4b331d80bc4daea15a7df4057205483b1f276 01:43:18 INFO - mozversion INFO | application_display_name: Nightly 01:43:18 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:43:18 INFO - mozversion INFO | application_name: Firefox 01:43:18 INFO - mozversion INFO | application_remotingname: firefox 01:43:18 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-beta 01:43:18 INFO - mozversion INFO | application_vendor: Mozilla 01:43:18 INFO - mozversion INFO | application_version: 44.0 01:43:18 INFO - mozversion INFO | platform_buildid: 20151214205110 01:43:18 INFO - mozversion INFO | platform_changeset: d1a4b331d80bc4daea15a7df4057205483b1f276 01:43:18 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-beta 01:43:18 INFO - mozversion INFO | platform_version: 44.0 01:43:18 INFO - 2015-12-15 01:43:18,288 DEBUG : using testdate: 1450172598 01:43:18 INFO - 2015-12-15 01:43:18,288 DEBUG : actual date: 1450172598 01:43:18 INFO - 2015-12-15 01:43:18,338 INFO : starting webserver on 'localhost:33447' 01:43:18 INFO - 2015-12-15 01:43:18,339 INFO : Starting test suite talos-linux64-ix-047 01:43:18 INFO - 2015-12-15 01:43:18,339 INFO : Starting test dromaeo_css 01:43:18 INFO - 2015-12-15 01:43:18,339 DEBUG : operating with platform_type : linux_ 01:43:18 INFO - 2015-12-15 01:43:18,340 INFO : Initialising browser for dromaeo_css test... 01:43:18 INFO - 2015-12-15 01:43:18,352 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpT8oOzj/profile http://localhost:33447/getInfo.html 01:43:21 INFO - 2015-12-15 01:43:21,807 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:43:21 INFO - 2015-12-15 01:43:21,807 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:43:21 INFO - 2015-12-15 01:43:21,807 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 01:43:21 INFO - 2015-12-15 01:43:21,807 DEBUG : BROWSER_OUTPUT: __metrics 01:43:21 INFO - 2015-12-15 01:43:21,908 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] 01:43:22 INFO - 2015-12-15 01:43:22,872 INFO : Browser initialized. 01:43:22 INFO - 2015-12-15 01:43:22,872 INFO : Running cycle 1/1 for dromaeo_css test... 01:43:22 INFO - 2015-12-15 01:43:22,873 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpT8oOzj/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:43:34 INFO - 2015-12-15 01:43:34,542 DEBUG : BROWSER_OUTPUT: RSS: Main: 130793472 01:43:34 INFO - 2015-12-15 01:43:34,543 DEBUG : BROWSER_OUTPUT: 01:44:25 INFO - 2015-12-15 01:44:25,331 DEBUG : BROWSER_OUTPUT: 1450172665327 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] 01:46:33 INFO - 2015-12-15 01:46:33,435 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33447/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33447/tests/dromaeo/cssquery-ext.html) 01:46:34 INFO - 2015-12-15 01:46:34,593 DEBUG : BROWSER_OUTPUT: RSS: Main: 242585600 01:46:34 INFO - 2015-12-15 01:46:34,593 DEBUG : BROWSER_OUTPUT: 01:49:36 INFO - 2015-12-15 01:49:36,640 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33447/tests/dromaeo/cssquery-ext.html (next: http://localhost:33447/tests/dromaeo/cssquery-jquery.html) 01:49:37 INFO - 2015-12-15 01:49:37,201 DEBUG : BROWSER_OUTPUT: RSS: Main: 209723392 01:49:37 INFO - 2015-12-15 01:49:37,201 DEBUG : BROWSER_OUTPUT: 01:52:38 INFO - 2015-12-15 01:52:38,849 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33447/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33447/tests/dromaeo/cssquery-mootools.html) 01:52:39 INFO - 2015-12-15 01:52:39,410 DEBUG : BROWSER_OUTPUT: RSS: Main: 208486400 01:52:39 INFO - 2015-12-15 01:52:39,411 DEBUG : BROWSER_OUTPUT: 01:55:41 INFO - 2015-12-15 01:55:41,143 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33447/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33447/tests/dromaeo/cssquery-prototype.html) 01:55:41 INFO - 2015-12-15 01:55:41,712 DEBUG : BROWSER_OUTPUT: RSS: Main: 200495104 01:55:41 INFO - 2015-12-15 01:55:41,712 DEBUG : BROWSER_OUTPUT: 01:58:44 INFO - 2015-12-15 01:58:44,002 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33447/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33447/tests/dromaeo/cssquery-yui.html) 01:58:44 INFO - 2015-12-15 01:58:44,584 DEBUG : BROWSER_OUTPUT: RSS: Main: 199311360 01:58:44 INFO - 2015-12-15 01:58:44,584 DEBUG : BROWSER_OUTPUT: 02:01:46 INFO - 2015-12-15 02:01:46,708 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33447/tests/dromaeo/cssquery-yui.html (next: http://localhost:33447/tests/dromaeo/cssquery-dojo.html) 02:01:46 INFO - 2015-12-15 02:01:46,967 DEBUG : BROWSER_OUTPUT: RSS: Main: 236736512 02:01:46 INFO - 2015-12-15 02:01:46,967 DEBUG : BROWSER_OUTPUT: 02:01:46 INFO - 2015-12-15 02:01:46,967 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:01:46 INFO - 2015-12-15 02:01:46,968 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:01:46 INFO - 2015-12-15 02:01:46,968 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:01:46 INFO - 2015-12-15 02:01:46,968 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:01:46 INFO - 2015-12-15 02:01:46,968 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3333.6333003369627;3419.6580341965823;3443.7589368744198;3448.1724386147334;3457.7579569430136;5610.158476228563;5628.718564071801;5667.0932650775885;5670.858228544288;5713;5682.6306290091115;5706.77172913083;5709.400512946143;5710.657360558369;5715.514181294585;4985.302057711923;5171.456997015306;5194.142966410538;5255.605829562779;5272.630915835893;5195.350581177353;5211.973940130294;5212.087884620195;5214.504622060898;5224;5089.2620570017325;5124.948750512484;5175.404828444721;5180.1452760294505;5247.055530004598;5089.770960306795;5196.558292545101;5203.583713302926;5208.635395522315;5236.109861323565;5199.688018718889;5222.164453687392;5249.1338929076655;5249.265102885599;5267.183586544092;5318.282031925679;5420.214068960018;5427.837164885021;5586.664800112007;5593.356763972155;6112.083187521863;6114.816555503342;6154.8769024619705;6155.10750941111;6182.783602573888;6168.475679567242;6176.166217560617;6203.937960620427;6217.285012223607;6218.253809542839;5462.126059830408;5584.022796010682;5669.999999999959;5768.509676677446;5783.855403614902;6161.137440758297;6216.098665693539;6227.470664993436;6236.18929539157;6249.000159974382;6019.729112189962;6041.879162416727;6060.454559089703;6063.969680151571;6073.028315469592;5855.151003104526;5954.791582294685;6066.4540191382985;6159.599626024294;6167.013277875519;6123.4488895999575;6127.295361033449;6133.907991380132;6137.171481849893;6144.477719393813;5881.235439392852;6114.505838208913;6114.969425152845;6120.525898559637;6125.960766318766;4646.744429056367;4647.535246475325;4657.906841863144;4664.463586687507;4675.111728771522;4131;4199.958000419957;4215.093754842724;4222.176675548239;4238.851640192578;5884.823455296348;5898.144769008555;5907.379725128885;5907.527397808165;5909.409059094056;5941.584089113807;6029.306629737549;6068.423499767515;6222.564420490522;6224.470919971763;5793.797217097382;5852.092925596539;5869.295684517885;5869.970650146722;5876.853078673067;5319.6808191508635;5366.195070739421;5372.650777699437;5373.435789242073;5373.731313434313;6090.604110732788;6161.383861613803;6176.722047507873;6304.148939893147;6383.585066970632;6142.539309551712;6207.037909124093;6216.72024758896;6221;6224.564280500322;6358.141650877257;6414.294427613052;6416;6422.775202867877;6422.775202867877;5805.709714514173;5915.852103697442;5926;6050.273967123973;6068.605540639845;6175.320714721287;6178.1350610913605;6194.5044396449075;6202.472789812917;6208.844778880383;5696.0316746154085;6014.2181516404335;6020.608660437058;6046.09308603713;6046.455818976313;5834.27071616048;5907;6008.218931538872;6011.218541589566;6037.607555508878;5932.021216499229;5941.643501389931;5983.880322393615;5986.790462333797;5987.101934709828;5843.620164689281;5995.490383317292;6039.245094363205;6073.605215660968;6087.147799308012;5877.970610146922;5970.283565971938;5979.760809567569;5996.970015149896;6004.5796794225735 02:01:46 INFO - 2015-12-15 02:01:46,968 DEBUG : BROWSER_OUTPUT: |1;ext.html;607.328901563772;637.1844039629275;644.3492073006262;649.1463725201363;651.8598501322215;33777.32445351095;44052.11895762087;44767.32849007267;44877.1024579509;44896.102077958465;48413;48697.269540956826;49024.2646360304;49060.50939490604;49081.263781043315;8366.665333386658;8483.618237179342;9193.218576420995;9379.15587597116;10595.152387808996;10822.404767737771;10922.399268040255;10928.235023548315;10946.069584085362;10950.835737463944;10778.029977302042;10865.782684346308;10875.293105948089;10890;10895.128389728803;10866.945665271662;10950.288231264942;10950.452477376099;10951.233413661046;10958.28771129878;10643.78712425755;10791.244612877103;10799;10804.405757683324;10805.081568066724;44068.11863762739;44540;44542.77728611336;44558.777206114086;44584.331235031175;3286.917827054319;3417.2482053948092;3472.1146107742616;3565.5008298838184;4359.411479450266;33022.6697733022;33058.504122438186;33089.33821323584;33246.6675333246;33572;3901.882943511699;3952.802359882023;4062.045419326456;4107.199096176247;4119.691023173274;300014;300425;302317;302322;450454.74772626255;56820.71589642025;73485.6325718368;74984.25015749881;75123.62438187774;75185;68914.65542672254;69506;69581;69623;69653;17843.10784460772;17992.640147196984;18119.45641630753;18125.818741812676;18148.637027259643;12745.553905613258;12785.360731963365;12815.935920320338;12818.9359053206;12850.228986260854;21938.89030554837;22126;22185.11259549632;22211;22288.88855555744;8058.153893841062;8368.372372071997;8392.4544904581;8418.326533877274;8437;990.2070703563005;1011.3426272922512;1085.4626959654863;1153.296489141623;1265.6266401411606;29190.27024324409;29198.7080129196;29519.409611807645;29715.85142074319;29715.85142074319;1106.4910141334915;1106.623747925709;1121.814900541418;1145.8223975283677;1248.1325478792153;14118.57644270653;14790.630234244014;15146;15235.923820380827;15939.601509962344;290125;293347;293762;293941;293965;54199.187012194845;54288.72855635697;54382.45617543853;54450.18324725132;54522.18216726752;1319.3139567424885;1369.7808350663845;1417.3196865504615;1507.8190617126015;1517.5523220649934;28892.42215155643;30248;30313.848430757706;30439.695603044573;31081;48600;49072;49080.75459622679;49088.28191013297;49113.50886491232;237160;239111;240316;240545;241270;33952.1511962193;34766.82616586901;34807.82596087104;35216.295674085864;35265.82367088148;48686.674980004296;49322.260166098255;49852;50073.24890126578;50172.379434037175;40994.59005410027;41989.16021679488;42540.57459425366;43267;43874.12251755011;41044.589554105274;41453;41801.58198417977;42353.364699530146;42401.78799105985;41062;41186.1762764749;41759;41791.283566568076;41819.790901046516;36510.269794604494;36797.63202367942;37113.814430927676;37610.247795044495;38004.61995380011;27766.167014989584;27774.305642358293;27903.302417439725;28056.71943280541;28106.578401323586 02:01:46 INFO - 2015-12-15 02:01:46,972 DEBUG : BROWSER_OUTPUT: |2;jquery.html;382.1859439394092;388.22549014715645;389.6648881961511;392.2840815511691;392.497603068073;12730.172538784997;15126.948686057362;17743.201555929983;19076.809231907675;19083.618327633438;18839.71740423895;19099.331523396682;19286.71069933952;19295.035248237567;19493.707594386062;5880.5295576354;6030.63816171029;6031.276246850362;6049.334573196945;6056.303525094627;4438.9556104439025;4672.789724462407;5940.138679891413;6387.201599800025;6586.440152587036;6289.308176100625;6472.482201423898;6488.93511064888;6517.217933847921;6535.379138981789;6390.584612000205;6426.100345951524;6431.710573024202;6434.260060093079;6461.6123032617725;4567.451905771329;4672.6261899047995;5792.68140252286;5797.101449275327;5803.071508558653;15135.697286054326;15278.770818437732;15317.080975141416;24224.2732718017;25141.49717005668;2403.182917807936;2406.338256979327;2452.5830608796546;2484.5527804995095;2488.203774792067;15392;15492.690146197127;15675.451359202374;15851;16229.675406491922;1954.3452943264024;2085.113826623679;2131.4138611881704;2162.945926351854;2183.727034120735;62783;68865;71307.93038104381;77107;77669.61165194194;17712.291508339524;17934.91032544829;17955.192016359295;18111.275548978156;18177.545561361072;27334;27350;27530.44939101207;27593;27711.168664940084;10378.636747713945;10427.11369533583;10484.737881553023;10494.26540142198;10511.737206569744;8752.956235218782;8903.06517815633;8971.955140224387;8994.685186018458;9040.18638322541;8848.159424854628;8929.821403572023;8957.820843583222;8971.865422018675;8994;1284.877936596022;1286.0740267007739;1286.1382873474795;1298.558490113366;2169.4034140611143;515.7704821354462;535.9356877174764;537.8628449745369;543.2042058384486;569.7094481814222;11471.770564588662;12706.237625742486;13148.107416368384;13321.600351989457;13843.792343114861;549.8872731090117;553.4880235781885;554.8557375082507;555.097965805566;560.7112337146373;5575.581831362583;7370.926290737131;7439.888401673979;7475.252474752481;7504.399648028145;626243;628945;637632;638310;645432;45019;45479.772601136785;45854.31218531725;86719.56640216759;87390.56304718563;608.349066498842;614.5605891787393;620.6989610039127;622.1849377315822;622.4460230394952;12334.444949977093;12431.502739890304;12539.059570532065;12626.494940202288;12627.494900204256;39855.601443985186;39950.40074398944;40287.39568906528;41390.793046034574;41410.58589414188;52553.47446525486;52578;53876.19185712296;54332.728336358065;55010;7700.730474433368;7795.064592248967;7806.804829879298;7812.53124812513;7819.569923654253;13536.120152190077;13646.454141834216;13805.24071176095;13850.792238116637;14109.082909610843;12041.698957526132;12150.027997760335;12232.633021009384;12282.692932676755;12389.504419823106;10149.64476243328;11966.940165299466;12069.336186509827;12079.939600302294;12108.031357491556;11962.282263064244;12225.144239903122;12250.081243906565;12269;12296.323702196465;7556;7571;7658.770236892902;7667.233276672511;7668.1181664109345;11658.358790266617;11776.4700588472;11935.641930742091;12010.939945300217;12102.394880255775 02:01:46 INFO - 2015-12-15 02:01:46,972 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1582.8417158284167;1595.3698289175768;1803.7925638551565;1810.5292623917778;1845.8523318134546;7787.4548781585245;7904.525728456297;7905.92094079059;7907.169747176543;7915.287624113828;6988.510804243705;7178;7539.509931854425;7761.223877612236;8185;2380.8571485710827;2389.7251816041203;2415.2874901903892;2417.9516409671796;2418.032786885251;2130.403487023636;2365.2431222008963;2397.580423425902;2441.072392490851;2449.3386785567886;2124.022949443258;2322.744498105207;2376.4534157143867;2378.8096952243777;2380.3573035280465;2381.8094552435764;2386.653935179398;2398.100712232913;2440.389902524369;2444.0956845967107;2354.270176245352;2367.124164059309;2370.7747763962398;2401.603735383677;2402.4114092047384;7944.2850143486785;7964.044314682217;7998.680052797881;8022;8042.839143217161;4969.031038947407;5049.34358533392;5051.292819005343;5052.292679024939;5053.1157047516535;3229.40256052631;3233.175540237248;3247;3263.102646772133;3289.1612638777196;1009.6314845081492;1024.3085917006065;1110.4336788238056;1155.0701685143456;1164.074560724218;10448.686539403754;10667.093297069758;10667.19996000303;10673.1995100367;10676.199285053652;4439.511653718088;4483.3947417098925;4513.842015529441;4523.095380923828;4524.253498172765;8783.121687831166;8798.736037918872;8800.911990880137;8801.955990220007;8801.955990220136;4945.2582112683385;4991.4758950310425;4999.600031997432;5001.5498605124985;5005.849824505271;4567.543245675406;4572.314152877028;4580.038191979722;4585.701929374647;4591.724496530219;3611.494390785292;3621.5654121505586;3649.835757390924;3674.6876515496483;3688.7602305850032;1017.4556612212579;1086.8043752124693;1123.7303047268597;1137.4085475552665;1141.3494308244387;1111.899929006377;1113.9108871290277;1181.3856794466828;1358.9932050339685;1404.9789253161211;7673.846523069619;7735.49719268257;7752.573608451589;7758.612069396508;7802.687892484237;1215.343714394235;1220.8840160184945;1225.7916154253799;1234.9073819463576;1238.331395841962;6248.625082495065;6277.964135917614;6362.618242905441;6362.681865906686;6368.681565921685;9393;9589.90410095904;9603.087706667855;9603.423794572209;9618.374805637612;9375.249980001583;9510.572024258925;9537.61849526025;9552.14030737237;9560.90439095614;7506.136794268729;7616.504927179715;7634.045744281965;7640.121386040565;7643.579603121771;7456.7762967111075;7483.70065197386;7576.6969321228735;7597.6581053851605;7602.657880395285;8480.957595211985;8600.311975041857;8601.612927418406;8664.436811607226;8714.738557843275;8719.128087191484;8797.560121994004;8840.690575829814;8846.778830529289;8977.326700497359;6934;7000.299970002959;7001.439884809305;7013.193482749549;7017.543859649107;7845.176256492986;7884.526928384315;7906.881396778937;8020.598970051591;8052.798680033046;6785.5250132490255;7360.484766066324;7409.851802964018;7441.702331906663;7462.253774622494;6744.494162937701;7238.819029524093;7248.383887369632;7320.377767889789;7329.047223860864;7424.36892864091;7452.776416707507;7466.925330746623;7470.850582988419;7474.7757567273065;6889.586624802528;6896.724131034903;6906.758263460755;6910.516263861682;6910.619915904674;6889.517733758589;7045.718171273296;7055.329743674342;7063.364297213276;7094.716211351488 02:01:46 INFO - 2015-12-15 02:01:46,972 DEBUG : BROWSER_OUTPUT: |4;prototype.html;365.56132640831004;369.55468660264387;373.1864535313018;376.1630372421361;382.1230276515397;5905.350411454737;5924.348321684612;5956.166136740849;5964.5526585506095;5980.222571065756;5679.375268720438;5727.11229759388;5731.45551172639;5813.970930145354;5863.618864773786;4537.228671125917;4567.771611419433;4569.543045695437;4569.565891240335;4574.931376029363;4559.974005848674;4579.267317229244;4600.608948239404;4617.699849509788;4621.653375996797;4578.336141259515;4581.106684196583;4582.954170458286;4583.587477127058;4592.1045396147765;4504.234280172363;4622.95377046232;4640.605548528345;4676.532346765331;4685.4377474702915;4161.375793630949;4167.4790651168605;4168.270552653274;4170.72890262132;4172.916541669149;5685.033544297479;5692.971535142339;5693.572982026365;5694.117411801178;5701.059325211335;5356.1697936819855;5424.918626220609;5445.727713614304;5461.2354270401775;5461.69960652164;6159.722812473449;6316.399942005502;6330.715117819663;6335.8732825343695;6337.524685648548;4610.746408947506;4610.746408947506;4613.215753321943;4613.584777370019;4614.723116613014;6507.739690412378;6509.739610415625;6513.348665133449;6515.413612774825;6518.185226846596;4663.207254766698;4725.527447255316;4733.124371991193;4735.881602959885;4753.239481682983;4790.161721698689;4814.181589129857;4815.061063092663;4816.494268101869;4818.132736107465;5422.295101636762;5425;5431.891362172734;5439.374471935778;5446.2375267462585;6367.681615919186;6371;6372.553921225563;6376.266729326094;6378.234611846516;1696.5249730075598;1733.8699597530235;1737.8870373425686;1740.2603893345279;1746.7030604797214;1124.1456493065166;1145.2326940949583;1166.9183157178916;1186.1637545530552;1196.5991392883307;5975.073863551156;6032.4570788629235;6039.969800150971;6048.425399587032;6073.1497590337385;6330.841728956813;6335.778247761306;6354.078658594478;6376.808695739135;6385.553011289165;6072.180255665517;6076.574639775174;6081.209442772411;6083.300420451616;6120.051392034242;3538.929221415557;3605.3149901518627;3605.3870841956405;3607.567091948983;3608.7293452990607;6734.797956061326;6751.628660423724;6755.3582409671;6757.222919364238;6769.763058293034;6521.11964884744;6662.56693314933;6665.633390163587;6676.732930682719;6676.766313179015;6738;6833.453323734089;6841.17905851311;6843.213030501456;6846.657667116624;6522.086907832812;6537.8692426152165;6581.736730530916;6585.835354116185;6592.571482853599;6309.242890853127;6502.317256687979;6503.902441463477;6505.024246363083;6511.576747511396;6837.692303846438;6841.350071743176;6843.623600702009;6843.794686159423;6853.725850965906;4600.907981840412;4616.815327386867;4621.815127394867;4624.5375462453485;4633.953660463487;6485.3514648534765;6589.374009469093;6596.637184954873;6600.768973085919;6604.735810567716;6419.679016049272;6423.9036414452885;6424.13274207976;6428.325025872216;6428.614283143026;6358.173437453286;6364.299927008118;6369.20384951881;6371.713272902638;6374.07575901501;5881.588288819913;6321.841953951188;6334.778282760081;6341.556091073765;6343.207099112611;5986.132010858314;6271.6550589718;6342.334054924167;6355.269144048493;6370.076338930921;6169.56813023102;6178.1350610913605;6181.629102253879;6182.938170618416;6188.288346840171 02:01:46 INFO - 2015-12-15 02:01:46,973 DEBUG : BROWSER_OUTPUT: |5;yui.html;841.0521123462265;946.3470205558165;951.3768481644521;952.4951775558956;966.700322899901;14777.630559236024;14959.925200373982;14999.1750453725;15008.699826003487;15167.696646067072;13924.443022279122;13981.720365592682;14000.64998375041;14008.299585020759;14026.43894244229;756.7086671631434;767.4972892755254;908.7500937242245;923.5843870258377;927.4157280913049;918.5361392496814;926.2080920812709;926.7127190570911;929;929.2890938432105;795.7214974758817;960.0591420408005;969.1713584884927;970.9757256068584;971.640493017581;799.2367289238763;945.8959514453404;961.528850863079;963.0898800633404;963.5663951221978;713.8108401273666;714.1893950366319;714.4962801225124;715.8711431942248;716.1120210938451;13683.179009259477;13742.725145497034;13745.587632371045;13751.449942002308;13790;13518.729625407535;13819.585412437644;13848.930755346159;13978.93010534951;14137.222452765094;10442.634507792267;10560.788784224349;11250.943745281304;11478.426078696115;11564.363959982198;3904.1801221743467;3939.881803545898;3964.207158568298;3968.384900340423;3981.6814654827544;52942.20586691203;53310.200346994825;54293.72853135748;54408.72795636036;54859;8697;8782.516961567047;9029.864552031724;9199.954000229956;11274.887251127384;14411;14536.636584085483;14553.563393098013;14561.053531520629;14578.708425831424;7330.7067717291775;7457.291557302047;7497.812554686177;7543.962280188564;7661.61691915402;4732.100900828831;4754.4532378776885;4827.806887724451;4829.13075646387;4856.757162141878;3075.8462076896067;3079.230192451887;3101.65881753007;3102.736267417295;3107.813531188136;492.3033907021596;495.1631742355408;505.6536272653244;509.1344713986238;514.5446280042189;613.3284053960906;680.9761658341935;719.9532030418006;742.1317059040935;757.4357103957586;9574.234061275081;9713.660021899199;9907.504624768733;9955.751106222402;9977.201823854219;568.3123420661046;669.7622344067884;690.2510775808204;702.2661318921739;706.3783870194299;4489.595936365743;4537.659675524349;4823.643942986902;4850.442199147073;4899.1426500362295;67343.66328168327;68337.65831170812;68400;68428;68526.65736671285;57873.71063144657;58904.7054764732;59595.702021490484;59599;59683.70158149181;52825.471745282826;53185.46814531805;53499;53749.462505375224;54325.1851222232;9404.529773511435;9428.292878034037;9448.48033358172;9456.669016584387;9465.242780577675;39303.60696393;39566;39580.80209598933;39683.2063358737;40455;49030.50969490402;51132.48867511277;51752.482475174766;51880.74059629829;52088.21867672064;8557.61490732906;8634.611442484978;8651.767841899913;8724.127587241224;8860.468371897707;12799.872001279868;13040.608781736562;13048.483946206294;13075.542356017875;13433.328333583086;11809.527618895148;11944.701382465508;11945.223560468541;12038.638840834788;12371.443285052013;11903.166778325434;12031.75936481248;12081.75836483283;12141;12287.078469114673;11495.31028138281;12015.939920300343;12186;12639;12723.80914286305;10173.745656358355;10661.09380702618;10702.89297107019;10899.727506812393;10989.505472253608;9933.751656208653;10250.487475626338;10331.586736530455;10361.585536578452;10439.94780026095 02:01:46 INFO - 2015-12-15 02:01:46,973 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:01:46 INFO - 2015-12-15 02:01:46,973 DEBUG : BROWSER_OUTPUT: __start_cc_report 02:01:46 INFO - 2015-12-15 02:01:46,973 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,914 02:01:46 INFO - 2015-12-15 02:01:46,973 DEBUG : BROWSER_OUTPUT: __end_cc_report 02:01:46 INFO - 2015-12-15 02:01:46,973 DEBUG : BROWSER_OUTPUT: __startTimestamp1450173706963__endTimestamp 02:01:46 INFO - 2015-12-15 02:01:46,974 DEBUG : BROWSER_OUTPUT: 02:01:46 INFO - 2015-12-15 02:01:46,974 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:01:46 INFO - 2015-12-15 02:01:46,974 DEBUG : BROWSER_OUTPUT: Number of tests: 6 02:01:46 INFO - 2015-12-15 02:01:46,974 DEBUG : BROWSER_OUTPUT: 02:01:46 INFO - 2015-12-15 02:01:46,974 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5686.41 Median:5909.41 stddev:637.25 (10.8%) stddev-sans-first:611.89 02:01:46 INFO - 2015-12-15 02:01:46,974 DEBUG : BROWSER_OUTPUT: Values: 3333.6 3419.7 3443.8 3448.2 3457.8 5610.2 5628.7 5667.1 5670.9 5713.0 5682.6 5706.8 5709.4 5710.7 5715.5 4985.3 5171.5 5194.1 5255.6 5272.6 5195.4 5212.0 5212.1 5214.5 5224.0 5089.3 5124.9 5175.4 5180.1 5247.1 5089.8 5196.6 5203.6 5208.6 5236.1 5199.7 5222.2 5249.1 5249.3 5267.2 5318.3 5420.2 5427.8 5586.7 5593.4 6112.1 6114.8 6154.9 6155.1 6182.8 6168.5 6176.2 6203.9 6217.3 6218.3 5462.1 5584.0 5670.0 5768.5 5783.9 6161.1 6216.1 6227.5 6236.2 6249.0 6019.7 6041.9 6060.5 6064.0 6073.0 5855.2 5954.8 6066.5 6159.6 6167.0 6123.4 6127.3 6133.9 6137.2 6144.5 5881.2 6114.5 6115.0 6120.5 6126.0 4646.7 4647.5 4657.9 4664.5 4675.1 4131.0 4200.0 4215.1 4222.2 4238.9 5884.8 5898.1 5907.4 5907.5 5909.4 5941.6 6029.3 6068.4 6222.6 6224.5 5793.8 5852.1 5869.3 5870.0 5876.9 5319.7 5366.2 5372.7 5373.4 5373.7 6090.6 6161.4 6176.7 6304.1 6383.6 6142.5 6207.0 6216.7 6221.0 6224.6 6358.1 6414.3 6416.0 6422.8 6422.8 5805.7 5915.9 5926.0 6050.3 6068.6 6175.3 6178.1 6194.5 6202.5 6208.8 5696.0 6014.2 6020.6 6046.1 6046.5 5834.3 5907.0 6008.2 6011.2 6037.6 5932.0 5941.6 5983.9 5986.8 5987.1 5843.6 5995.5 6039.2 6073.6 6087.1 5878.0 5970.3 5979.8 5997.0 6004.6 02:01:46 INFO - 2015-12-15 02:01:46,974 DEBUG : BROWSER_OUTPUT: 02:01:46 INFO - 2015-12-15 02:01:46,974 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:48690.03 Median:33864.74 stddev:76317.67 (225.4%) stddev-sans-first:76446.37 02:01:46 INFO - 2015-12-15 02:01:46,974 DEBUG : BROWSER_OUTPUT: Values: 607.3 637.2 644.3 649.1 651.9 33777.3 44052.1 44767.3 44877.1 44896.1 48413.0 48697.3 49024.3 49060.5 49081.3 8366.7 8483.6 9193.2 9379.2 10595.2 10822.4 10922.4 10928.2 10946.1 10950.8 10778.0 10865.8 10875.3 10890.0 10895.1 10866.9 10950.3 10950.5 10951.2 10958.3 10643.8 10791.2 10799.0 10804.4 10805.1 44068.1 44540.0 44542.8 44558.8 44584.3 3286.9 3417.2 3472.1 3565.5 4359.4 33022.7 33058.5 33089.3 33246.7 33572.0 3901.9 3952.8 4062.0 4107.2 4119.7 300014.0 300425.0 302317.0 302322.0 450454.7 56820.7 73485.6 74984.3 75123.6 75185.0 68914.7 69506.0 69581.0 69623.0 69653.0 17843.1 17992.6 18119.5 18125.8 18148.6 12745.6 12785.4 12815.9 12818.9 12850.2 21938.9 22126.0 22185.1 22211.0 22288.9 8058.2 8368.4 8392.5 8418.3 8437.0 990.2 1011.3 1085.5 1153.3 1265.6 29190.3 29198.7 29519.4 29715.9 29715.9 1106.5 1106.6 1121.8 1145.8 1248.1 14118.6 14790.6 15146.0 15235.9 15939.6 290125.0 293347.0 293762.0 293941.0 293965.0 54199.2 54288.7 54382.5 54450.2 54522.2 1319.3 1369.8 1417.3 1507.8 1517.6 28892.4 30248.0 30313.8 30439.7 31081.0 48600.0 49072.0 49080.8 49088.3 49113.5 237160.0 239111.0 240316.0 240545.0 241270.0 33952.2 34766.8 34807.8 35216.3 35265.8 48686.7 49322.3 49852.0 50073.2 50172.4 40994.6 41989.2 42540.6 43267.0 43874.1 41044.6 41453.0 41801.6 42353.4 42401.8 41062.0 41186.2 41759.0 41791.3 41819.8 36510.3 36797.6 37113.8 37610.2 38004.6 27766.2 27774.3 27903.3 28056.7 28106.6 02:01:46 INFO - 2015-12-15 02:01:46,974 DEBUG : BROWSER_OUTPUT: 02:01:46 INFO - 2015-12-15 02:01:46,975 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:32092.81 Median:39903.00 stddev:103652.48 (259.8%) stddev-sans-first:103915.90 02:01:46 INFO - 2015-12-15 02:01:46,976 DEBUG : BROWSER_OUTPUT: Values: 382.2 388.2 389.7 392.3 392.5 12730.2 15126.9 17743.2 19076.8 19083.6 18839.7 19099.3 19286.7 19295.0 19493.7 5880.5 6030.6 6031.3 6049.3 6056.3 4439.0 4672.8 5940.1 6387.2 6586.4 6289.3 6472.5 6488.9 6517.2 6535.4 6390.6 6426.1 6431.7 6434.3 6461.6 4567.5 4672.6 5792.7 5797.1 5803.1 15135.7 15278.8 15317.1 24224.3 25141.5 2403.2 2406.3 2452.6 2484.6 2488.2 15392.0 15492.7 15675.5 15851.0 16229.7 1954.3 2085.1 2131.4 2162.9 2183.7 62783.0 68865.0 71307.9 77107.0 77669.6 17712.3 17934.9 17955.2 18111.3 18177.5 27334.0 27350.0 27530.4 27593.0 27711.2 10378.6 10427.1 10484.7 10494.3 10511.7 8753.0 8903.1 8972.0 8994.7 9040.2 8848.2 8929.8 8957.8 8971.9 8994.0 1284.9 1286.1 1286.1 1298.6 2169.4 515.8 535.9 537.9 543.2 569.7 11471.8 12706.2 13148.1 13321.6 13843.8 549.9 553.5 554.9 555.1 560.7 5575.6 7370.9 7439.9 7475.3 7504.4 626243.0 628945.0 637632.0 638310.0 645432.0 45019.0 45479.8 45854.3 86719.6 87390.6 608.3 614.6 620.7 622.2 622.4 12334.4 12431.5 12539.1 12626.5 12627.5 39855.6 39950.4 40287.4 41390.8 41410.6 52553.5 52578.0 53876.2 54332.7 55010.0 7700.7 7795.1 7806.8 7812.5 7819.6 13536.1 13646.5 13805.2 13850.8 14109.1 12041.7 12150.0 12232.6 12282.7 12389.5 10149.6 11966.9 12069.3 12079.9 12108.0 11962.3 12225.1 12250.1 12269.0 12296.3 7556.0 7571.0 7658.8 7667.2 7668.1 11658.4 11776.5 11935.6 12010.9 12102.4 02:01:46 INFO - 2015-12-15 02:01:46,976 DEBUG : BROWSER_OUTPUT: 02:01:46 INFO - 2015-12-15 02:01:46,976 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5656.01 Median:6765.01 stddev:2855.64 (42.2%) stddev-sans-first:2847.24 02:01:46 INFO - 2015-12-15 02:01:46,976 DEBUG : BROWSER_OUTPUT: Values: 1582.8 1595.4 1803.8 1810.5 1845.9 7787.5 7904.5 7905.9 7907.2 7915.3 6988.5 7178.0 7539.5 7761.2 8185.0 2380.9 2389.7 2415.3 2418.0 2418.0 2130.4 2365.2 2397.6 2441.1 2449.3 2124.0 2322.7 2376.5 2378.8 2380.4 2381.8 2386.7 2398.1 2440.4 2444.1 2354.3 2367.1 2370.8 2401.6 2402.4 7944.3 7964.0 7998.7 8022.0 8042.8 4969.0 5049.3 5051.3 5052.3 5053.1 3229.4 3233.2 3247.0 3263.1 3289.2 1009.6 1024.3 1110.4 1155.1 1164.1 10448.7 10667.1 10667.2 10673.2 10676.2 4439.5 4483.4 4513.8 4523.1 4524.3 8783.1 8798.7 8800.9 8802.0 8802.0 4945.3 4991.5 4999.6 5001.5 5005.8 4567.5 4572.3 4580.0 4585.7 4591.7 3611.5 3621.6 3649.8 3674.7 3688.8 1017.5 1086.8 1123.7 1137.4 1141.3 1111.9 1113.9 1181.4 1359.0 1405.0 7673.8 7735.5 7752.6 7758.6 7802.7 1215.3 1220.9 1225.8 1234.9 1238.3 6248.6 6278.0 6362.6 6362.7 6368.7 9393.0 9589.9 9603.1 9603.4 9618.4 9375.2 9510.6 9537.6 9552.1 9560.9 7506.1 7616.5 7634.0 7640.1 7643.6 7456.8 7483.7 7576.7 7597.7 7602.7 8481.0 8600.3 8601.6 8664.4 8714.7 8719.1 8797.6 8840.7 8846.8 8977.3 6934.0 7000.3 7001.4 7013.2 7017.5 7845.2 7884.5 7906.9 8020.6 8052.8 6785.5 7360.5 7409.9 7441.7 7462.3 6744.5 7238.8 7248.4 7320.4 7329.0 7424.4 7452.8 7466.9 7470.9 7474.8 6889.6 6896.7 6906.8 6910.5 6910.6 6889.5 7045.7 7055.3 7063.4 7094.7 02:01:46 INFO - 2015-12-15 02:01:46,976 DEBUG : BROWSER_OUTPUT: 02:01:46 INFO - 2015-12-15 02:01:46,976 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5339.88 Median:5977.65 stddev:1556.77 (26.0%) stddev-sans-first:1515.71 02:01:46 INFO - 2015-12-15 02:01:46,976 DEBUG : BROWSER_OUTPUT: Values: 365.6 369.6 373.2 376.2 382.1 5905.4 5924.3 5956.2 5964.6 5980.2 5679.4 5727.1 5731.5 5814.0 5863.6 4537.2 4567.8 4569.5 4569.6 4574.9 4560.0 4579.3 4600.6 4617.7 4621.7 4578.3 4581.1 4583.0 4583.6 4592.1 4504.2 4623.0 4640.6 4676.5 4685.4 4161.4 4167.5 4168.3 4170.7 4172.9 5685.0 5693.0 5693.6 5694.1 5701.1 5356.2 5424.9 5445.7 5461.2 5461.7 6159.7 6316.4 6330.7 6335.9 6337.5 4610.7 4610.7 4613.2 4613.6 4614.7 6507.7 6509.7 6513.3 6515.4 6518.2 4663.2 4725.5 4733.1 4735.9 4753.2 4790.2 4814.2 4815.1 4816.5 4818.1 5422.3 5425.0 5431.9 5439.4 5446.2 6367.7 6371.0 6372.6 6376.3 6378.2 1696.5 1733.9 1737.9 1740.3 1746.7 1124.1 1145.2 1166.9 1186.2 1196.6 5975.1 6032.5 6040.0 6048.4 6073.1 6330.8 6335.8 6354.1 6376.8 6385.6 6072.2 6076.6 6081.2 6083.3 6120.1 3538.9 3605.3 3605.4 3607.6 3608.7 6734.8 6751.6 6755.4 6757.2 6769.8 6521.1 6662.6 6665.6 6676.7 6676.8 6738.0 6833.5 6841.2 6843.2 6846.7 6522.1 6537.9 6581.7 6585.8 6592.6 6309.2 6502.3 6503.9 6505.0 6511.6 6837.7 6841.4 6843.6 6843.8 6853.7 4600.9 4616.8 4621.8 4624.5 4634.0 6485.4 6589.4 6596.6 6600.8 6604.7 6419.7 6423.9 6424.1 6428.3 6428.6 6358.2 6364.3 6369.2 6371.7 6374.1 5881.6 6321.8 6334.8 6341.6 6343.2 5986.1 6271.7 6342.3 6355.3 6370.1 6169.6 6178.1 6181.6 6182.9 6188.3 02:01:46 INFO - 2015-12-15 02:01:46,977 DEBUG : BROWSER_OUTPUT: 02:01:46 INFO - 2015-12-15 02:01:46,977 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:15188.93 Median:25823.52 stddev:18511.29 (71.7%) stddev-sans-first:18531.86 02:01:46 INFO - 2015-12-15 02:01:46,978 DEBUG : BROWSER_OUTPUT: Values: 841.1 946.3 951.4 952.5 966.7 14777.6 14959.9 14999.2 15008.7 15167.7 13924.4 13981.7 14000.6 14008.3 14026.4 756.7 767.5 908.8 923.6 927.4 918.5 926.2 926.7 929.0 929.3 795.7 960.1 969.2 971.0 971.6 799.2 945.9 961.5 963.1 963.6 713.8 714.2 714.5 715.9 716.1 13683.2 13742.7 13745.6 13751.4 13790.0 13518.7 13819.6 13848.9 13978.9 14137.2 10442.6 10560.8 11250.9 11478.4 11564.4 3904.2 3939.9 3964.2 3968.4 3981.7 52942.2 53310.2 54293.7 54408.7 54859.0 8697.0 8782.5 9029.9 9200.0 11274.9 14411.0 14536.6 14553.6 14561.1 14578.7 7330.7 7457.3 7497.8 7544.0 7661.6 4732.1 4754.5 4827.8 4829.1 4856.8 3075.8 3079.2 3101.7 3102.7 3107.8 492.3 495.2 505.7 509.1 514.5 613.3 681.0 720.0 742.1 757.4 9574.2 9713.7 9907.5 9955.8 9977.2 568.3 669.8 690.3 702.3 706.4 4489.6 4537.7 4823.6 4850.4 4899.1 67343.7 68337.7 68400.0 68428.0 68526.7 57873.7 58904.7 59595.7 59599.0 59683.7 52825.5 53185.5 53499.0 53749.5 54325.2 9404.5 9428.3 9448.5 9456.7 9465.2 39303.6 39566.0 39580.8 39683.2 40455.0 49030.5 51132.5 51752.5 51880.7 52088.2 8557.6 8634.6 8651.8 8724.1 8860.5 12799.9 13040.6 13048.5 13075.5 13433.3 11809.5 11944.7 11945.2 12038.6 12371.4 11903.2 12031.8 12081.8 12141.0 12287.1 11495.3 12015.9 12186.0 12639.0 12723.8 10173.7 10661.1 10702.9 10899.7 10989.5 9933.8 10250.5 10331.6 10361.6 10439.9 02:01:46 INFO - 2015-12-15 02:01:46,978 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:01:46 INFO - 2015-12-15 02:01:46,978 DEBUG : BROWSER_OUTPUT: 02:01:47 INFO - 2015-12-15 02:01:47,462 INFO : Browser exited with error code: 0 02:01:47 INFO - 2015-12-15 02:01:47,480 INFO : Completed test dromaeo_css (00:18:29) 02:01:47 INFO - 2015-12-15 02:01:47,480 INFO : Starting test kraken 02:01:47 INFO - 2015-12-15 02:01:47,480 DEBUG : operating with platform_type : linux_ 02:01:47 INFO - 2015-12-15 02:01:47,480 INFO : Initialising browser for kraken test... 02:01:47 INFO - 2015-12-15 02:01:47,486 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpce85_n/profile http://localhost:33447/getInfo.html 02:01:51 INFO - 2015-12-15 02:01:51,034 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:01:51 INFO - 2015-12-15 02:01:51,034 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:01:51 INFO - 2015-12-15 02:01:51,034 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 02:01:51 INFO - 2015-12-15 02:01:51,034 DEBUG : BROWSER_OUTPUT: __metrics 02:01:51 INFO - 2015-12-15 02:01:51,110 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] 02:01:52 INFO - 2015-12-15 02:01:52,156 INFO : Browser initialized. 02:01:52 INFO - 2015-12-15 02:01:52,157 INFO : Running cycle 1/1 for kraken test... 02:01:52 INFO - 2015-12-15 02:01:52,157 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpce85_n/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:02:03 INFO - 2015-12-15 02:02:03,835 DEBUG : BROWSER_OUTPUT: RSS: Main: 131092480 02:02:03 INFO - 2015-12-15 02:02:03,836 DEBUG : BROWSER_OUTPUT: 02:02:06 INFO - 2015-12-15 02:02:06,263 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33447/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33447/tests/kraken/driver.html?testName=audio-beat-detection) 02:02:06 INFO - 2015-12-15 02:02:06,828 DEBUG : BROWSER_OUTPUT: RSS: Main: 164622336 02:02:06 INFO - 2015-12-15 02:02:06,828 DEBUG : BROWSER_OUTPUT: 02:02:09 INFO - 2015-12-15 02:02:09,377 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33447/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33447/tests/kraken/driver.html?testName=audio-dft) 02:02:09 INFO - 2015-12-15 02:02:09,943 DEBUG : BROWSER_OUTPUT: RSS: Main: 163688448 02:02:09 INFO - 2015-12-15 02:02:09,943 DEBUG : BROWSER_OUTPUT: 02:02:12 INFO - 2015-12-15 02:02:12,726 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33447/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33447/tests/kraken/driver.html?testName=audio-fft) 02:02:13 INFO - 2015-12-15 02:02:13,287 DEBUG : BROWSER_OUTPUT: RSS: Main: 160841728 02:02:13 INFO - 2015-12-15 02:02:13,287 DEBUG : BROWSER_OUTPUT: 02:02:15 INFO - 2015-12-15 02:02:15,235 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33447/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33447/tests/kraken/driver.html?testName=audio-oscillator) 02:02:15 INFO - 2015-12-15 02:02:15,816 DEBUG : BROWSER_OUTPUT: RSS: Main: 160215040 02:02:15 INFO - 2015-12-15 02:02:15,817 DEBUG : BROWSER_OUTPUT: 02:02:17 INFO - 2015-12-15 02:02:17,939 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33447/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33447/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:02:18 INFO - 2015-12-15 02:02:18,493 DEBUG : BROWSER_OUTPUT: RSS: Main: 157749248 02:02:18 INFO - 2015-12-15 02:02:18,493 DEBUG : BROWSER_OUTPUT: 02:02:21 INFO - 2015-12-15 02:02:21,334 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33447/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33447/tests/kraken/driver.html?testName=imaging-darkroom) 02:02:21 INFO - 2015-12-15 02:02:21,895 DEBUG : BROWSER_OUTPUT: RSS: Main: 158212096 02:02:21 INFO - 2015-12-15 02:02:21,895 DEBUG : BROWSER_OUTPUT: 02:02:25 INFO - 2015-12-15 02:02:25,211 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33447/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33447/tests/kraken/driver.html?testName=imaging-desaturate) 02:02:25 INFO - 2015-12-15 02:02:25,773 DEBUG : BROWSER_OUTPUT: RSS: Main: 159805440 02:02:25 INFO - 2015-12-15 02:02:25,773 DEBUG : BROWSER_OUTPUT: 02:02:28 INFO - 2015-12-15 02:02:28,456 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33447/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33447/tests/kraken/driver.html?testName=json-parse-financial) 02:02:29 INFO - 2015-12-15 02:02:29,023 DEBUG : BROWSER_OUTPUT: RSS: Main: 158834688 02:02:29 INFO - 2015-12-15 02:02:29,023 DEBUG : BROWSER_OUTPUT: 02:02:30 INFO - 2015-12-15 02:02:30,551 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33447/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33447/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:02:31 INFO - 2015-12-15 02:02:31,100 DEBUG : BROWSER_OUTPUT: RSS: Main: 160739328 02:02:31 INFO - 2015-12-15 02:02:31,101 DEBUG : BROWSER_OUTPUT: 02:02:32 INFO - 2015-12-15 02:02:32,815 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33447/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33447/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:02:33 INFO - 2015-12-15 02:02:33,402 DEBUG : BROWSER_OUTPUT: RSS: Main: 160264192 02:02:33 INFO - 2015-12-15 02:02:33,402 DEBUG : BROWSER_OUTPUT: 02:02:35 INFO - 2015-12-15 02:02:35,375 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33447/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33447/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:02:35 INFO - 2015-12-15 02:02:35,937 DEBUG : BROWSER_OUTPUT: RSS: Main: 163282944 02:02:35 INFO - 2015-12-15 02:02:35,937 DEBUG : BROWSER_OUTPUT: 02:02:38 INFO - 2015-12-15 02:02:38,272 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33447/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33447/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:02:38 INFO - 2015-12-15 02:02:38,838 DEBUG : BROWSER_OUTPUT: RSS: Main: 168296448 02:02:38 INFO - 2015-12-15 02:02:38,838 DEBUG : BROWSER_OUTPUT: 02:02:41 INFO - 2015-12-15 02:02:41,239 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33447/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33447/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:02:41 INFO - 2015-12-15 02:02:41,805 DEBUG : BROWSER_OUTPUT: RSS: Main: 167981056 02:02:41 INFO - 2015-12-15 02:02:41,806 DEBUG : BROWSER_OUTPUT: 02:02:43 INFO - 2015-12-15 02:02:43,406 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33447/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33447/tests/kraken/driver.html?testName=ai-astar) 02:02:43 INFO - 2015-12-15 02:02:43,656 DEBUG : BROWSER_OUTPUT: RSS: Main: 226521088 02:02:43 INFO - 2015-12-15 02:02:43,656 DEBUG : BROWSER_OUTPUT: 02:02:43 INFO - 2015-12-15 02:02:43,657 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:02:43 INFO - 2015-12-15 02:02:43,658 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:02:43 INFO - 2015-12-15 02:02:43,658 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:02:43 INFO - 2015-12-15 02:02:43,658 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:02:43 INFO - 2015-12-15 02:02:43,659 DEBUG : BROWSER_OUTPUT: |0;ai-astar;107;110;103;109;109;110;100;110;113;110 02:02:43 INFO - 2015-12-15 02:02:43,659 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;159;126;142;166;123;149;148;122;163;123 02:02:43 INFO - 2015-12-15 02:02:43,659 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;162;159;159;162;160;159;162;160;161 02:02:43 INFO - 2015-12-15 02:02:43,659 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;71;72;138;71;72;72;72;153;72 02:02:43 INFO - 2015-12-15 02:02:43,659 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;90;90;135;89;90;90;134;90;91;133 02:02:43 INFO - 2015-12-15 02:02:43,660 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;109;109;109;110;110;109;109 02:02:43 INFO - 2015-12-15 02:02:43,660 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;144;145;145;145;146;145;146;145;145 02:02:43 INFO - 2015-12-15 02:02:43,660 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;95;95;96;96;96;96;96;95 02:02:43 INFO - 2015-12-15 02:02:43,660 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;57;57;58;56;57;56;58;57;54;64 02:02:43 INFO - 2015-12-15 02:02:43,661 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;63;64;63;63;63;64;64;64;69;64 02:02:43 INFO - 2015-12-15 02:02:43,661 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;78;75;80;78;78;77;76;77;78;77 02:02:43 INFO - 2015-12-15 02:02:43,661 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;108;121;111;122;116;131;114;110;115;108 02:02:43 INFO - 2015-12-15 02:02:43,661 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;139;137;134;140;142;126;135;134;141;134 02:02:43 INFO - 2015-12-15 02:02:43,661 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;64;64;62;63;62;62;63;62;62;61 02:02:43 INFO - 2015-12-15 02:02:43,662 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:02:43 INFO - 2015-12-15 02:02:43,662 DEBUG : BROWSER_OUTPUT: __start_cc_report 02:02:43 INFO - 2015-12-15 02:02:43,662 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,848 02:02:43 INFO - 2015-12-15 02:02:43,662 DEBUG : BROWSER_OUTPUT: __end_cc_report 02:02:43 INFO - 2015-12-15 02:02:43,663 DEBUG : BROWSER_OUTPUT: __startTimestamp1450173763656__endTimestamp 02:02:43 INFO - 2015-12-15 02:02:43,663 DEBUG : BROWSER_OUTPUT: 02:02:43 INFO - 2015-12-15 02:02:43,664 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:02:43 INFO - 2015-12-15 02:02:43,665 DEBUG : BROWSER_OUTPUT: Number of tests: 14 02:02:43 INFO - 2015-12-15 02:02:43,665 DEBUG : BROWSER_OUTPUT: 02:02:43 INFO - 2015-12-15 02:02:43,665 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.10 Median:110.00 stddev:3.84 (3.5%) stddev-sans-first:4.06 02:02:43 INFO - 2015-12-15 02:02:43,666 DEBUG : BROWSER_OUTPUT: Values: 107.0 110.0 103.0 109.0 109.0 110.0 100.0 110.0 113.0 110.0 02:02:43 INFO - 2015-12-15 02:02:43,666 DEBUG : BROWSER_OUTPUT: 02:02:43 INFO - 2015-12-15 02:02:43,666 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:142.10 Median:148.50 stddev:17.54 (11.8%) stddev-sans-first:17.51 02:02:43 INFO - 2015-12-15 02:02:43,667 DEBUG : BROWSER_OUTPUT: Values: 159.0 126.0 142.0 166.0 123.0 149.0 148.0 122.0 163.0 123.0 02:02:43 INFO - 2015-12-15 02:02:43,667 DEBUG : BROWSER_OUTPUT: 02:02:43 INFO - 2015-12-15 02:02:43,667 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.50 Median:161.00 stddev:1.27 (0.8%) stddev-sans-first:1.33 02:02:43 INFO - 2015-12-15 02:02:43,667 DEBUG : BROWSER_OUTPUT: Values: 161.0 162.0 159.0 159.0 162.0 160.0 159.0 162.0 160.0 161.0 02:02:43 INFO - 2015-12-15 02:02:43,668 DEBUG : BROWSER_OUTPUT: 02:02:43 INFO - 2015-12-15 02:02:43,668 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:86.40 Median:72.00 stddev:31.35 (43.5%) stddev-sans-first:32.75 02:02:43 INFO - 2015-12-15 02:02:43,668 DEBUG : BROWSER_OUTPUT: Values: 71.0 71.0 72.0 138.0 71.0 72.0 72.0 72.0 153.0 72.0 02:02:43 INFO - 2015-12-15 02:02:43,669 DEBUG : BROWSER_OUTPUT: 02:02:43 INFO - 2015-12-15 02:02:43,669 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:103.20 Median:90.00 stddev:21.26 (23.6%) stddev-sans-first:22.01 02:02:43 INFO - 2015-12-15 02:02:43,669 DEBUG : BROWSER_OUTPUT: Values: 90.0 90.0 135.0 89.0 90.0 90.0 134.0 90.0 91.0 133.0 02:02:43 INFO - 2015-12-15 02:02:43,669 DEBUG : BROWSER_OUTPUT: 02:02:43 INFO - 2015-12-15 02:02:43,669 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 02:02:43 INFO - 2015-12-15 02:02:43,669 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 109.0 109.0 109.0 110.0 110.0 109.0 109.0 02:02:43 INFO - 2015-12-15 02:02:43,670 DEBUG : BROWSER_OUTPUT: 02:02:43 INFO - 2015-12-15 02:02:43,671 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.10 Median:145.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 02:02:43 INFO - 2015-12-15 02:02:43,671 DEBUG : BROWSER_OUTPUT: Values: 145.0 144.0 145.0 145.0 145.0 146.0 145.0 146.0 145.0 145.0 02:02:43 INFO - 2015-12-15 02:02:43,671 DEBUG : BROWSER_OUTPUT: 02:02:43 INFO - 2015-12-15 02:02:43,671 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 02:02:43 INFO - 2015-12-15 02:02:43,671 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 95.0 95.0 96.0 96.0 96.0 96.0 96.0 95.0 02:02:43 INFO - 2015-12-15 02:02:43,671 DEBUG : BROWSER_OUTPUT: 02:02:43 INFO - 2015-12-15 02:02:43,671 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:57.40 Median:57.00 stddev:2.59 (4.5%) stddev-sans-first:2.74 02:02:43 INFO - 2015-12-15 02:02:43,671 DEBUG : BROWSER_OUTPUT: Values: 57.0 57.0 58.0 56.0 57.0 56.0 58.0 57.0 54.0 64.0 02:02:43 INFO - 2015-12-15 02:02:43,672 DEBUG : BROWSER_OUTPUT: 02:02:43 INFO - 2015-12-15 02:02:43,672 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:64.10 Median:64.00 stddev:1.79 (2.8%) stddev-sans-first:1.86 02:02:43 INFO - 2015-12-15 02:02:43,672 DEBUG : BROWSER_OUTPUT: Values: 63.0 64.0 63.0 63.0 63.0 64.0 64.0 64.0 69.0 64.0 02:02:43 INFO - 2015-12-15 02:02:43,672 DEBUG : BROWSER_OUTPUT: 02:02:43 INFO - 2015-12-15 02:02:43,672 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:77.40 Median:78.00 stddev:1.35 (1.7%) stddev-sans-first:1.41 02:02:43 INFO - 2015-12-15 02:02:43,672 DEBUG : BROWSER_OUTPUT: Values: 78.0 75.0 80.0 78.0 78.0 77.0 76.0 77.0 78.0 77.0 02:02:43 INFO - 2015-12-15 02:02:43,672 DEBUG : BROWSER_OUTPUT: 02:02:43 INFO - 2015-12-15 02:02:43,672 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:115.60 Median:115.50 stddev:7.29 (6.3%) stddev-sans-first:7.20 02:02:43 INFO - 2015-12-15 02:02:43,672 DEBUG : BROWSER_OUTPUT: Values: 108.0 121.0 111.0 122.0 116.0 131.0 114.0 110.0 115.0 108.0 02:02:43 INFO - 2015-12-15 02:02:43,673 DEBUG : BROWSER_OUTPUT: 02:02:43 INFO - 2015-12-15 02:02:43,673 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:136.20 Median:138.00 stddev:4.71 (3.4%) stddev-sans-first:4.88 02:02:43 INFO - 2015-12-15 02:02:43,673 DEBUG : BROWSER_OUTPUT: Values: 139.0 137.0 134.0 140.0 142.0 126.0 135.0 134.0 141.0 134.0 02:02:43 INFO - 2015-12-15 02:02:43,673 DEBUG : BROWSER_OUTPUT: 02:02:43 INFO - 2015-12-15 02:02:43,673 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.50 Median:62.50 stddev:0.97 (1.6%) stddev-sans-first:0.87 02:02:43 INFO - 2015-12-15 02:02:43,673 DEBUG : BROWSER_OUTPUT: Values: 64.0 64.0 62.0 63.0 62.0 62.0 63.0 62.0 62.0 61.0 02:02:43 INFO - 2015-12-15 02:02:43,673 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:02:43 INFO - 2015-12-15 02:02:43,673 DEBUG : BROWSER_OUTPUT: 02:02:44 INFO - 2015-12-15 02:02:44,301 INFO : Browser exited with error code: 0 02:02:44 INFO - 2015-12-15 02:02:44,356 INFO : Completed test kraken (00:00:56) 02:02:44 INFO - 2015-12-15 02:02:44,356 INFO : Starting test v8_7 02:02:44 INFO - 2015-12-15 02:02:44,356 DEBUG : operating with platform_type : linux_ 02:02:44 INFO - 2015-12-15 02:02:44,356 INFO : Initialising browser for v8_7 test... 02:02:44 INFO - 2015-12-15 02:02:44,362 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp64phVp/profile http://localhost:33447/getInfo.html 02:02:47 INFO - 2015-12-15 02:02:47,800 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:02:47 INFO - 2015-12-15 02:02:47,800 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:02:47 INFO - 2015-12-15 02:02:47,800 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 02:02:47 INFO - 2015-12-15 02:02:47,800 DEBUG : BROWSER_OUTPUT: __metrics 02:02:47 INFO - 2015-12-15 02:02:47,949 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] 02:02:48 INFO - 2015-12-15 02:02:48,882 INFO : Browser initialized. 02:02:48 INFO - 2015-12-15 02:02:48,882 INFO : Running cycle 1/1 for v8_7 test... 02:02:48 INFO - 2015-12-15 02:02:48,882 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp64phVp/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:03:00 INFO - 2015-12-15 02:03:00,521 DEBUG : BROWSER_OUTPUT: RSS: Main: 131698688 02:03:00 INFO - 2015-12-15 02:03:00,522 DEBUG : BROWSER_OUTPUT: 02:03:21 INFO - 2015-12-15 02:03:21,858 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33447/tests/v8_7/run.html (next: http://localhost:33447/tests/v8_7/run.html) 02:03:22 INFO - 2015-12-15 02:03:22,109 DEBUG : BROWSER_OUTPUT: RSS: Main: 423043072 02:03:22 INFO - 2015-12-15 02:03:22,109 DEBUG : BROWSER_OUTPUT: 02:03:22 INFO - 2015-12-15 02:03:22,110 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:03:22 INFO - 2015-12-15 02:03:22,110 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:03:22 INFO - 2015-12-15 02:03:22,110 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:03:22 INFO - 2015-12-15 02:03:22,111 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:03:22 INFO - 2015-12-15 02:03:22,111 DEBUG : BROWSER_OUTPUT: |0;Richards;163.61256544502618 02:03:22 INFO - 2015-12-15 02:03:22,111 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;172.59233690024163 02:03:22 INFO - 2015-12-15 02:03:22,111 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.4076557697681 02:03:22 INFO - 2015-12-15 02:03:22,111 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5010 02:03:22 INFO - 2015-12-15 02:03:22,111 DEBUG : BROWSER_OUTPUT: |4;RayTrace;959.6928982725528 02:03:22 INFO - 2015-12-15 02:03:22,111 DEBUG : BROWSER_OUTPUT: |5;Earley;553.7098560354374 02:03:22 INFO - 2015-12-15 02:03:22,112 DEBUG : BROWSER_OUTPUT: |6;Boyer;10557.894736842105 02:03:22 INFO - 2015-12-15 02:03:22,112 DEBUG : BROWSER_OUTPUT: |7;RegExp;24585.365853658535 02:03:22 INFO - 2015-12-15 02:03:22,112 DEBUG : BROWSER_OUTPUT: |8;Splay;529.6610169491526 02:03:22 INFO - 2015-12-15 02:03:22,112 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4822.115384615385 02:03:22 INFO - 2015-12-15 02:03:22,112 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:03:22 INFO - 2015-12-15 02:03:22,112 DEBUG : BROWSER_OUTPUT: __startTimestamp1450173802109__endTimestamp 02:03:22 INFO - 2015-12-15 02:03:22,113 DEBUG : BROWSER_OUTPUT: 02:03:22 INFO - 2015-12-15 02:03:22,113 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:03:22 INFO - 2015-12-15 02:03:22,113 DEBUG : BROWSER_OUTPUT: Number of tests: 10 02:03:22 INFO - 2015-12-15 02:03:22,114 DEBUG : BROWSER_OUTPUT: 02:03:22 INFO - 2015-12-15 02:03:22,114 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:163.61 Median:163.61 stddev:0.00 (0.0%) 02:03:22 INFO - 2015-12-15 02:03:22,114 DEBUG : BROWSER_OUTPUT: Values: 163.6 02:03:22 INFO - 2015-12-15 02:03:22,115 DEBUG : BROWSER_OUTPUT: 02:03:22 INFO - 2015-12-15 02:03:22,115 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:172.59 Median:172.59 stddev:0.00 (0.0%) 02:03:22 INFO - 2015-12-15 02:03:22,115 DEBUG : BROWSER_OUTPUT: Values: 172.6 02:03:22 INFO - 2015-12-15 02:03:22,115 DEBUG : BROWSER_OUTPUT: 02:03:22 INFO - 2015-12-15 02:03:22,115 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.41 Median:279.41 stddev:0.00 (0.0%) 02:03:22 INFO - 2015-12-15 02:03:22,115 DEBUG : BROWSER_OUTPUT: Values: 279.4 02:03:22 INFO - 2015-12-15 02:03:22,115 DEBUG : BROWSER_OUTPUT: 02:03:22 INFO - 2015-12-15 02:03:22,116 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5010.00 Median:5010.00 stddev:0.00 (0.0%) 02:03:22 INFO - 2015-12-15 02:03:22,116 DEBUG : BROWSER_OUTPUT: Values: 5010.0 02:03:22 INFO - 2015-12-15 02:03:22,116 DEBUG : BROWSER_OUTPUT: 02:03:22 INFO - 2015-12-15 02:03:22,116 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:959.69 Median:959.69 stddev:0.00 (0.0%) 02:03:22 INFO - 2015-12-15 02:03:22,116 DEBUG : BROWSER_OUTPUT: Values: 959.7 02:03:22 INFO - 2015-12-15 02:03:22,116 DEBUG : BROWSER_OUTPUT: 02:03:22 INFO - 2015-12-15 02:03:22,116 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:553.71 Median:553.71 stddev:0.00 (0.0%) 02:03:22 INFO - 2015-12-15 02:03:22,117 DEBUG : BROWSER_OUTPUT: Values: 553.7 02:03:22 INFO - 2015-12-15 02:03:22,117 DEBUG : BROWSER_OUTPUT: 02:03:22 INFO - 2015-12-15 02:03:22,117 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10557.89 Median:10557.89 stddev:0.00 (0.0%) 02:03:22 INFO - 2015-12-15 02:03:22,117 DEBUG : BROWSER_OUTPUT: Values: 10557.9 02:03:22 INFO - 2015-12-15 02:03:22,117 DEBUG : BROWSER_OUTPUT: 02:03:22 INFO - 2015-12-15 02:03:22,117 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24585.37 Median:24585.37 stddev:0.00 (0.0%) 02:03:22 INFO - 2015-12-15 02:03:22,117 DEBUG : BROWSER_OUTPUT: Values: 24585.4 02:03:22 INFO - 2015-12-15 02:03:22,117 DEBUG : BROWSER_OUTPUT: 02:03:22 INFO - 2015-12-15 02:03:22,117 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:529.66 Median:529.66 stddev:0.00 (0.0%) 02:03:22 INFO - 2015-12-15 02:03:22,117 DEBUG : BROWSER_OUTPUT: Values: 529.7 02:03:22 INFO - 2015-12-15 02:03:22,117 DEBUG : BROWSER_OUTPUT: 02:03:22 INFO - 2015-12-15 02:03:22,117 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 02:03:22 INFO - 2015-12-15 02:03:22,118 DEBUG : BROWSER_OUTPUT: Values: 4822.1 02:03:22 INFO - 2015-12-15 02:03:22,118 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:03:22 INFO - 2015-12-15 02:03:22,118 DEBUG : BROWSER_OUTPUT: 02:03:22 INFO - 2015-12-15 02:03:22,813 INFO : Browser exited with error code: 0 02:03:22 INFO - 2015-12-15 02:03:22,827 INFO : Completed test v8_7 (00:00:38) 02:03:23 INFO - 2015-12-15 02:03:23,163 INFO : Completed test suite (00:20:04) 02:03:23 INFO - 2015-12-15 02:03:23,163 DEBUG : Working with test: dromaeo_css 02:03:23 INFO - 2015-12-15 02:03:23,163 DEBUG : Generating results file: dromaeo_css 02:03:23 INFO - 2015-12-15 02:03:23,164 DEBUG : Working with test: kraken 02:03:23 INFO - 2015-12-15 02:03:23,165 DEBUG : Generating results file: kraken 02:03:23 INFO - 2015-12-15 02:03:23,165 INFO : javascript benchmark 02:03:23 INFO - 2015-12-15 02:03:23,165 DEBUG : Working with test: v8_7 02:03:23 INFO - 2015-12-15 02:03:23,165 DEBUG : Generating results file: v8_7 02:03:23 INFO - 2015-12-15 02:03:23,166 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:03:23 INFO - 2015-12-15 02:03:23,224 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,53,35]] 02:03:23 INFO - 2015-12-15 02:03:23,224 DEBUG : process_Request line: dromaeo_css 7353.84 graph.html#tests=[[72,53,35]] 02:03:23 INFO - 2015-12-15 02:03:23,224 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:03:23 INFO - 2015-12-15 02:03:23,253 DEBUG : process_Request line: kraken 1463.70 graph.html#tests=[[232,53,35]] 02:03:23 INFO - 2015-12-15 02:03:23,253 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:03:23 INFO - 2015-12-15 02:03:23,288 DEBUG : process_Request line: v8_7 23174.04 graph.html#tests=[[230,53,35]] 02:03:23 INFO - 2015-12-15 02:03:23,289 INFO : javascript benchmark 02:03:23 INFO - 2015-12-15 02:03:23,293 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3333.6333003369627, 3419.6580341965823, 3443.7589368744198, 3448.1724386147334, 3457.7579569430136, 5610.158476228563, 5628.718564071801, 5667.0932650775885, 5670.858228544288, 5713.0, 5682.6306290091115, 5706.77172913083, 5709.400512946143, 5710.657360558369, 5715.514181294585, 4985.302057711923, 5171.456997015306, 5194.142966410538, 5255.605829562779, 5272.630915835893, 5195.350581177353, 5211.973940130294, 5212.087884620195, 5214.504622060898, 5224.0, 5089.2620570017325, 5124.948750512484, 5175.404828444721, 5180.1452760294505, 5247.055530004598, 5089.770960306795, 5196.558292545101, 5203.583713302926, 5208.635395522315, 5236.109861323565, 5199.688018718889, 5222.164453687392, 5249.1338929076655, 5249.265102885599, 5267.183586544092, 5318.282031925679, 5420.214068960018, 5427.837164885021, 5586.664800112007, 5593.356763972155, 6112.083187521863, 6114.816555503342, 6154.8769024619705, 6155.10750941111, 6182.783602573888, 6168.475679567242, 6176.166217560617, 6203.937960620427, 6217.285012223607, 6218.253809542839, 5462.126059830408, 5584.022796010682, 5669.999999999959, 5768.509676677446, 5783.855403614902, 6161.137440758297, 6216.098665693539, 6227.470664993436, 6236.18929539157, 6249.000159974382, 6019.729112189962, 6041.879162416727, 6060.454559089703, 6063.969680151571, 6073.028315469592, 5855.151003104526, 5954.791582294685, 6066.4540191382985, 6159.599626024294, 6167.013277875519, 6123.4488895999575, 6127.295361033449, 6133.907991380132, 6137.171481849893, 6144.477719393813, 5881.235439392852, 6114.505838208913, 6114.969425152845, 6120.525898559637, 6125.960766318766, 4646.744429056367, 4647.535246475325, 4657.906841863144, 4664.463586687507, 4675.111728771522, 4131.0, 4199.958000419957, 4215.093754842724, 4222.176675548239, 4238.851640192578, 5884.823455296348, 5898.144769008555, 5907.379725128885, 5907.527397808165, 5909.409059094056, 5941.584089113807, 6029.306629737549, 6068.423499767515, 6222.564420490522, 6224.470919971763, 5793.797217097382, 5852.092925596539, 5869.295684517885, 5869.970650146722, 5876.853078673067, 5319.6808191508635, 5366.195070739421, 5372.650777699437, 5373.435789242073, 5373.731313434313, 6090.604110732788, 6161.383861613803, 6176.722047507873, 6304.148939893147, 6383.585066970632, 6142.539309551712, 6207.037909124093, 6216.72024758896, 6221.0, 6224.564280500322, 6358.141650877257, 6414.294427613052, 6416.0, 6422.775202867877, 6422.775202867877, 5805.709714514173, 5915.852103697442, 5926.0, 6050.273967123973, 6068.605540639845, 6175.320714721287, 6178.1350610913605, 6194.5044396449075, 6202.472789812917, 6208.844778880383, 5696.0316746154085, 6014.2181516404335, 6020.608660437058, 6046.09308603713, 6046.455818976313, 5834.27071616048, 5907.0, 6008.218931538872, 6011.218541589566, 6037.607555508878, 5932.021216499229, 5941.643501389931, 5983.880322393615, 5986.790462333797, 5987.101934709828, 5843.620164689281, 5995.490383317292, 6039.245094363205, 6073.605215660968, 6087.147799308012, 5877.970610146922, 5970.283565971938, 5979.760809567569, 5996.970015149896, 6004.5796794225735], "unit": "ms", "name": "dojo.html", "value": 5644.818415208405}, {"lowerIsBetter": false, "replicates": [607.328901563772, 637.1844039629275, 644.3492073006262, 649.1463725201363, 651.8598501322215, 33777.32445351095, 44052.11895762087, 44767.32849007267, 44877.1024579509, 44896.102077958465, 48413.0, 48697.269540956826, 49024.2646360304, 49060.50939490604, 49081.263781043315, 8366.665333386658, 8483.618237179342, 9193.218576420995, 9379.15587597116, 10595.152387808996, 10822.404767737771, 10922.399268040255, 10928.235023548315, 10946.069584085362, 10950.835737463944, 10778.029977302042, 10865.782684346308, 10875.293105948089, 10890.0, 10895.128389728803, 10866.945665271662, 10950.288231264942, 10950.452477376099, 10951.233413661046, 10958.28771129878, 10643.78712425755, 10791.244612877103, 10799.0, 10804.405757683324, 10805.081568066724, 44068.11863762739, 44540.0, 44542.77728611336, 44558.777206114086, 44584.331235031175, 3286.917827054319, 3417.2482053948092, 3472.1146107742616, 3565.5008298838184, 4359.411479450266, 33022.6697733022, 33058.504122438186, 33089.33821323584, 33246.6675333246, 33572.0, 3901.882943511699, 3952.802359882023, 4062.045419326456, 4107.199096176247, 4119.691023173274, 300014.0, 300425.0, 302317.0, 302322.0, 450454.74772626255, 56820.71589642025, 73485.6325718368, 74984.25015749881, 75123.62438187774, 75185.0, 68914.65542672254, 69506.0, 69581.0, 69623.0, 69653.0, 17843.10784460772, 17992.640147196984, 18119.45641630753, 18125.818741812676, 18148.637027259643, 12745.553905613258, 12785.360731963365, 12815.935920320338, 12818.9359053206, 12850.228986260854, 21938.89030554837, 22126.0, 22185.11259549632, 22211.0, 22288.88855555744, 8058.153893841062, 8368.372372071997, 8392.4544904581, 8418.326533877274, 8437.0, 990.2070703563005, 1011.3426272922512, 1085.4626959654863, 1153.296489141623, 1265.6266401411606, 29190.27024324409, 29198.7080129196, 29519.409611807645, 29715.85142074319, 29715.85142074319, 1106.4910141334915, 1106.623747925709, 1121.814900541418, 1145.8223975283677, 1248.1325478792153, 14118.57644270653, 14790.630234244014, 15146.0, 15235.923820380827, 15939.601509962344, 290125.0, 293347.0, 293762.0, 293941.0, 293965.0, 54199.187012194845, 54288.72855635697, 54382.45617543853, 54450.18324725132, 54522.18216726752, 1319.3139567424885, 1369.7808350663845, 1417.3196865504615, 1507.8190617126015, 1517.5523220649934, 28892.42215155643, 30248.0, 30313.848430757706, 30439.695603044573, 31081.0, 48600.0, 49072.0, 49080.75459622679, 49088.28191013297, 49113.50886491232, 237160.0, 239111.0, 240316.0, 240545.0, 241270.0, 33952.1511962193, 34766.82616586901, 34807.82596087104, 35216.295674085864, 35265.82367088148, 48686.674980004296, 49322.260166098255, 49852.0, 50073.24890126578, 50172.379434037175, 40994.59005410027, 41989.16021679488, 42540.57459425366, 43267.0, 43874.12251755011, 41044.589554105274, 41453.0, 41801.58198417977, 42353.364699530146, 42401.78799105985, 41062.0, 41186.1762764749, 41759.0, 41791.283566568076, 41819.790901046516, 36510.269794604494, 36797.63202367942, 37113.814430927676, 37610.247795044495, 38004.61995380011, 27766.167014989584, 27774.305642358293, 27903.302417439725, 28056.71943280541, 28106.578401323586], "unit": "ms", "name": "ext.html", "value": 20450.146113270675}, {"lowerIsBetter": false, "replicates": [382.1859439394092, 388.22549014715645, 389.6648881961511, 392.2840815511691, 392.497603068073, 12730.172538784997, 15126.948686057362, 17743.201555929983, 19076.809231907675, 19083.618327633438, 18839.71740423895, 19099.331523396682, 19286.71069933952, 19295.035248237567, 19493.707594386062, 5880.5295576354, 6030.63816171029, 6031.276246850362, 6049.334573196945, 6056.303525094627, 4438.9556104439025, 4672.789724462407, 5940.138679891413, 6387.201599800025, 6586.440152587036, 6289.308176100625, 6472.482201423898, 6488.93511064888, 6517.217933847921, 6535.379138981789, 6390.584612000205, 6426.100345951524, 6431.710573024202, 6434.260060093079, 6461.6123032617725, 4567.451905771329, 4672.6261899047995, 5792.68140252286, 5797.101449275327, 5803.071508558653, 15135.697286054326, 15278.770818437732, 15317.080975141416, 24224.2732718017, 25141.49717005668, 2403.182917807936, 2406.338256979327, 2452.5830608796546, 2484.5527804995095, 2488.203774792067, 15392.0, 15492.690146197127, 15675.451359202374, 15851.0, 16229.675406491922, 1954.3452943264024, 2085.113826623679, 2131.4138611881704, 2162.945926351854, 2183.727034120735, 62783.0, 68865.0, 71307.93038104381, 77107.0, 77669.61165194194, 17712.291508339524, 17934.91032544829, 17955.192016359295, 18111.275548978156, 18177.545561361072, 27334.0, 27350.0, 27530.44939101207, 27593.0, 27711.168664940084, 10378.636747713945, 10427.11369533583, 10484.737881553023, 10494.26540142198, 10511.737206569744, 8752.956235218782, 8903.06517815633, 8971.955140224387, 8994.685186018458, 9040.18638322541, 8848.159424854628, 8929.821403572023, 8957.820843583222, 8971.865422018675, 8994.0, 1284.877936596022, 1286.0740267007739, 1286.1382873474795, 1298.558490113366, 2169.4034140611143, 515.7704821354462, 535.9356877174764, 537.8628449745369, 543.2042058384486, 569.7094481814222, 11471.770564588662, 12706.237625742486, 13148.107416368384, 13321.600351989457, 13843.792343114861, 549.8872731090117, 553.4880235781885, 554.8557375082507, 555.097965805566, 560.7112337146373, 5575.581831362583, 7370.926290737131, 7439.888401673979, 7475.252474752481, 7504.399648028145, 626243.0, 628945.0, 637632.0, 638310.0, 645432.0, 45019.0, 45479.772601136785, 45854.31218531725, 86719.56640216759, 87390.56304718563, 608.349066498842, 614.5605891787393, 620.6989610039127, 622.1849377315822, 622.4460230394952, 12334.444949977093, 12431.502739890304, 12539.059570532065, 12626.494940202288, 12627.494900204256, 39855.601443985186, 39950.40074398944, 40287.39568906528, 41390.793046034574, 41410.58589414188, 52553.47446525486, 52578.0, 53876.19185712296, 54332.728336358065, 55010.0, 7700.730474433368, 7795.064592248967, 7806.804829879298, 7812.53124812513, 7819.569923654253, 13536.120152190077, 13646.454141834216, 13805.24071176095, 13850.792238116637, 14109.082909610843, 12041.698957526132, 12150.027997760335, 12232.633021009384, 12282.692932676755, 12389.504419823106, 10149.64476243328, 11966.940165299466, 12069.336186509827, 12079.939600302294, 12108.031357491556, 11962.282263064244, 12225.144239903122, 12250.081243906565, 12269.0, 12296.323702196465, 7556.0, 7571.0, 7658.770236892902, 7667.233276672511, 7668.1181664109345, 11658.358790266617, 11776.4700588472, 11935.641930742091, 12010.939945300217, 12102.394880255775], "unit": "ms", "name": "jquery.html", "value": 8961.297000703053}, {"lowerIsBetter": false, "replicates": [1582.8417158284167, 1595.3698289175768, 1803.7925638551565, 1810.5292623917778, 1845.8523318134546, 7787.4548781585245, 7904.525728456297, 7905.92094079059, 7907.169747176543, 7915.287624113828, 6988.510804243705, 7178.0, 7539.509931854425, 7761.223877612236, 8185.0, 2380.8571485710827, 2389.7251816041203, 2415.2874901903892, 2417.9516409671796, 2418.032786885251, 2130.403487023636, 2365.2431222008963, 2397.580423425902, 2441.072392490851, 2449.3386785567886, 2124.022949443258, 2322.744498105207, 2376.4534157143867, 2378.8096952243777, 2380.3573035280465, 2381.8094552435764, 2386.653935179398, 2398.100712232913, 2440.389902524369, 2444.0956845967107, 2354.270176245352, 2367.124164059309, 2370.7747763962398, 2401.603735383677, 2402.4114092047384, 7944.2850143486785, 7964.044314682217, 7998.680052797881, 8022.0, 8042.839143217161, 4969.031038947407, 5049.34358533392, 5051.292819005343, 5052.292679024939, 5053.1157047516535, 3229.40256052631, 3233.175540237248, 3247.0, 3263.102646772133, 3289.1612638777196, 1009.6314845081492, 1024.3085917006065, 1110.4336788238056, 1155.0701685143456, 1164.074560724218, 10448.686539403754, 10667.093297069758, 10667.19996000303, 10673.1995100367, 10676.199285053652, 4439.511653718088, 4483.3947417098925, 4513.842015529441, 4523.095380923828, 4524.253498172765, 8783.121687831166, 8798.736037918872, 8800.911990880137, 8801.955990220007, 8801.955990220136, 4945.2582112683385, 4991.4758950310425, 4999.600031997432, 5001.5498605124985, 5005.849824505271, 4567.543245675406, 4572.314152877028, 4580.038191979722, 4585.701929374647, 4591.724496530219, 3611.494390785292, 3621.5654121505586, 3649.835757390924, 3674.6876515496483, 3688.7602305850032, 1017.4556612212579, 1086.8043752124693, 1123.7303047268597, 1137.4085475552665, 1141.3494308244387, 1111.899929006377, 1113.9108871290277, 1181.3856794466828, 1358.9932050339685, 1404.9789253161211, 7673.846523069619, 7735.49719268257, 7752.573608451589, 7758.612069396508, 7802.687892484237, 1215.343714394235, 1220.8840160184945, 1225.7916154253799, 1234.9073819463576, 1238.331395841962, 6248.625082495065, 6277.964135917614, 6362.618242905441, 6362.681865906686, 6368.681565921685, 9393.0, 9589.90410095904, 9603.087706667855, 9603.423794572209, 9618.374805637612, 9375.249980001583, 9510.572024258925, 9537.61849526025, 9552.14030737237, 9560.90439095614, 7506.136794268729, 7616.504927179715, 7634.045744281965, 7640.121386040565, 7643.579603121771, 7456.7762967111075, 7483.70065197386, 7576.6969321228735, 7597.6581053851605, 7602.657880395285, 8480.957595211985, 8600.311975041857, 8601.612927418406, 8664.436811607226, 8714.738557843275, 8719.128087191484, 8797.560121994004, 8840.690575829814, 8846.778830529289, 8977.326700497359, 6934.0, 7000.299970002959, 7001.439884809305, 7013.193482749549, 7017.543859649107, 7845.176256492986, 7884.526928384315, 7906.881396778937, 8020.598970051591, 8052.798680033046, 6785.5250132490255, 7360.484766066324, 7409.851802964018, 7441.702331906663, 7462.253774622494, 6744.494162937701, 7238.819029524093, 7248.383887369632, 7320.377767889789, 7329.047223860864, 7424.36892864091, 7452.776416707507, 7466.925330746623, 7470.850582988419, 7474.7757567273065, 6889.586624802528, 6896.724131034903, 6906.758263460755, 6910.516263861682, 6910.619915904674, 6889.517733758589, 7045.718171273296, 7055.329743674342, 7063.364297213276, 7094.716211351488], "unit": "ms", "name": "mootools.html", "value": 4677.892534838256}, {"lowerIsBetter": false, "replicates": [365.56132640831004, 369.55468660264387, 373.1864535313018, 376.1630372421361, 382.1230276515397, 5905.350411454737, 5924.348321684612, 5956.166136740849, 5964.5526585506095, 5980.222571065756, 5679.375268720438, 5727.11229759388, 5731.45551172639, 5813.970930145354, 5863.618864773786, 4537.228671125917, 4567.771611419433, 4569.543045695437, 4569.565891240335, 4574.931376029363, 4559.974005848674, 4579.267317229244, 4600.608948239404, 4617.699849509788, 4621.653375996797, 4578.336141259515, 4581.106684196583, 4582.954170458286, 4583.587477127058, 4592.1045396147765, 4504.234280172363, 4622.95377046232, 4640.605548528345, 4676.532346765331, 4685.4377474702915, 4161.375793630949, 4167.4790651168605, 4168.270552653274, 4170.72890262132, 4172.916541669149, 5685.033544297479, 5692.971535142339, 5693.572982026365, 5694.117411801178, 5701.059325211335, 5356.1697936819855, 5424.918626220609, 5445.727713614304, 5461.2354270401775, 5461.69960652164, 6159.722812473449, 6316.399942005502, 6330.715117819663, 6335.8732825343695, 6337.524685648548, 4610.746408947506, 4610.746408947506, 4613.215753321943, 4613.584777370019, 4614.723116613014, 6507.739690412378, 6509.739610415625, 6513.348665133449, 6515.413612774825, 6518.185226846596, 4663.207254766698, 4725.527447255316, 4733.124371991193, 4735.881602959885, 4753.239481682983, 4790.161721698689, 4814.181589129857, 4815.061063092663, 4816.494268101869, 4818.132736107465, 5422.295101636762, 5425.0, 5431.891362172734, 5439.374471935778, 5446.2375267462585, 6367.681615919186, 6371.0, 6372.553921225563, 6376.266729326094, 6378.234611846516, 1696.5249730075598, 1733.8699597530235, 1737.8870373425686, 1740.2603893345279, 1746.7030604797214, 1124.1456493065166, 1145.2326940949583, 1166.9183157178916, 1186.1637545530552, 1196.5991392883307, 5975.073863551156, 6032.4570788629235, 6039.969800150971, 6048.425399587032, 6073.1497590337385, 6330.841728956813, 6335.778247761306, 6354.078658594478, 6376.808695739135, 6385.553011289165, 6072.180255665517, 6076.574639775174, 6081.209442772411, 6083.300420451616, 6120.051392034242, 3538.929221415557, 3605.3149901518627, 3605.3870841956405, 3607.567091948983, 3608.7293452990607, 6734.797956061326, 6751.628660423724, 6755.3582409671, 6757.222919364238, 6769.763058293034, 6521.11964884744, 6662.56693314933, 6665.633390163587, 6676.732930682719, 6676.766313179015, 6738.0, 6833.453323734089, 6841.17905851311, 6843.213030501456, 6846.657667116624, 6522.086907832812, 6537.8692426152165, 6581.736730530916, 6585.835354116185, 6592.571482853599, 6309.242890853127, 6502.317256687979, 6503.902441463477, 6505.024246363083, 6511.576747511396, 6837.692303846438, 6841.350071743176, 6843.623600702009, 6843.794686159423, 6853.725850965906, 4600.907981840412, 4616.815327386867, 4621.815127394867, 4624.5375462453485, 4633.953660463487, 6485.3514648534765, 6589.374009469093, 6596.637184954873, 6600.768973085919, 6604.735810567716, 6419.679016049272, 6423.9036414452885, 6424.13274207976, 6428.325025872216, 6428.614283143026, 6358.173437453286, 6364.299927008118, 6369.20384951881, 6371.713272902638, 6374.07575901501, 5881.588288819913, 6321.841953951188, 6334.778282760081, 6341.556091073765, 6343.207099112611, 5986.132010858314, 6271.6550589718, 6342.334054924167, 6355.269144048493, 6370.076338930921, 6169.56813023102, 6178.1350610913605, 6181.629102253879, 6182.938170618416, 6188.288346840171], "unit": "ms", "name": "prototype.html", "value": 4852.024844182363}, {"lowerIsBetter": false, "replicates": [841.0521123462265, 946.3470205558165, 951.3768481644521, 952.4951775558956, 966.700322899901, 14777.630559236024, 14959.925200373982, 14999.1750453725, 15008.699826003487, 15167.696646067072, 13924.443022279122, 13981.720365592682, 14000.64998375041, 14008.299585020759, 14026.43894244229, 756.7086671631434, 767.4972892755254, 908.7500937242245, 923.5843870258377, 927.4157280913049, 918.5361392496814, 926.2080920812709, 926.7127190570911, 929.0, 929.2890938432105, 795.7214974758817, 960.0591420408005, 969.1713584884927, 970.9757256068584, 971.640493017581, 799.2367289238763, 945.8959514453404, 961.528850863079, 963.0898800633404, 963.5663951221978, 713.8108401273666, 714.1893950366319, 714.4962801225124, 715.8711431942248, 716.1120210938451, 13683.179009259477, 13742.725145497034, 13745.587632371045, 13751.449942002308, 13790.0, 13518.729625407535, 13819.585412437644, 13848.930755346159, 13978.93010534951, 14137.222452765094, 10442.634507792267, 10560.788784224349, 11250.943745281304, 11478.426078696115, 11564.363959982198, 3904.1801221743467, 3939.881803545898, 3964.207158568298, 3968.384900340423, 3981.6814654827544, 52942.20586691203, 53310.200346994825, 54293.72853135748, 54408.72795636036, 54859.0, 8697.0, 8782.516961567047, 9029.864552031724, 9199.954000229956, 11274.887251127384, 14411.0, 14536.636584085483, 14553.563393098013, 14561.053531520629, 14578.708425831424, 7330.7067717291775, 7457.291557302047, 7497.812554686177, 7543.962280188564, 7661.61691915402, 4732.100900828831, 4754.4532378776885, 4827.806887724451, 4829.13075646387, 4856.757162141878, 3075.8462076896067, 3079.230192451887, 3101.65881753007, 3102.736267417295, 3107.813531188136, 492.3033907021596, 495.1631742355408, 505.6536272653244, 509.1344713986238, 514.5446280042189, 613.3284053960906, 680.9761658341935, 719.9532030418006, 742.1317059040935, 757.4357103957586, 9574.234061275081, 9713.660021899199, 9907.504624768733, 9955.751106222402, 9977.201823854219, 568.3123420661046, 669.7622344067884, 690.2510775808204, 702.2661318921739, 706.3783870194299, 4489.595936365743, 4537.659675524349, 4823.643942986902, 4850.442199147073, 4899.1426500362295, 67343.66328168327, 68337.65831170812, 68400.0, 68428.0, 68526.65736671285, 57873.71063144657, 58904.7054764732, 59595.702021490484, 59599.0, 59683.70158149181, 52825.471745282826, 53185.46814531805, 53499.0, 53749.462505375224, 54325.1851222232, 9404.529773511435, 9428.292878034037, 9448.48033358172, 9456.669016584387, 9465.242780577675, 39303.60696393, 39566.0, 39580.80209598933, 39683.2063358737, 40455.0, 49030.50969490402, 51132.48867511277, 51752.482475174766, 51880.74059629829, 52088.21867672064, 8557.61490732906, 8634.611442484978, 8651.767841899913, 8724.127587241224, 8860.468371897707, 12799.872001279868, 13040.608781736562, 13048.483946206294, 13075.542356017875, 13433.328333583086, 11809.527618895148, 11944.701382465508, 11945.223560468541, 12038.638840834788, 12371.443285052013, 11903.166778325434, 12031.75936481248, 12081.75836483283, 12141.0, 12287.078469114673, 11495.31028138281, 12015.939920300343, 12186.0, 12639.0, 12723.80914286305, 10173.745656358355, 10661.09380702618, 10702.89297107019, 10899.727506812393, 10989.505472253608, 9933.751656208653, 10250.487475626338, 10331.586736530455, 10361.585536578452, 10439.94780026095], "unit": "ms", "name": "yui.html", "value": 6735.270735155781}], "name": "dromaeo_css", "value": 7353.838960299567}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [107.0, 110.0, 103.0, 109.0, 109.0, 110.0, 100.0, 110.0, 113.0, 110.0], "unit": "ms", "name": "ai-astar", "value": 108.1}, {"lowerIsBetter": true, "replicates": [159.0, 126.0, 142.0, 166.0, 123.0, 149.0, 148.0, 122.0, 163.0, 123.0], "unit": "ms", "name": "audio-beat-detection", "value": 142.1}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 159.0, 159.0, 162.0, 160.0, 159.0, 162.0, 160.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 160.5}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 72.0, 138.0, 71.0, 72.0, 72.0, 72.0, 153.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 86.4}, {"lowerIsBetter": true, "replicates": [90.0, 90.0, 135.0, 89.0, 90.0, 90.0, 134.0, 90.0, 91.0, 133.0], "unit": "ms", "name": "audio-oscillator", "value": 103.2}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 109.0, 109.0, 109.0, 110.0, 110.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.5}, {"lowerIsBetter": true, "replicates": [145.0, 144.0, 145.0, 145.0, 145.0, 146.0, 145.0, 146.0, 145.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.1}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [57.0, 57.0, 58.0, 56.0, 57.0, 56.0, 58.0, 57.0, 54.0, 64.0], "unit": "ms", "name": "json-parse-financial", "value": 57.4}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 63.0, 63.0, 63.0, 64.0, 64.0, 64.0, 69.0, 64.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 64.1}, {"lowerIsBetter": true, "replicates": [78.0, 75.0, 80.0, 78.0, 78.0, 77.0, 76.0, 77.0, 78.0, 77.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 77.4}, {"lowerIsBetter": true, "replicates": [108.0, 121.0, 111.0, 122.0, 116.0, 131.0, 114.0, 110.0, 115.0, 108.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 115.6}, {"lowerIsBetter": true, "replicates": [139.0, 137.0, 134.0, 140.0, 142.0, 126.0, 135.0, 134.0, 141.0, 134.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 136.2}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 62.0, 63.0, 62.0, 62.0, 63.0, 62.0, 62.0, 61.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 62.5}], "name": "kraken", "value": 1463.7}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [163.61256544502618], "unit": "score", "name": "Richards", "value": 215.76582400000007}, {"lowerIsBetter": false, "replicates": [172.59233690024163], "unit": "score", "name": "DeltaBlue", "value": 383.0876919999999}, {"lowerIsBetter": false, "replicates": [279.4076557697681], "unit": "score", "name": "Encrypt", "value": 952.6617989999997}, {"lowerIsBetter": false, "replicates": [5010.0], "unit": "score", "name": "Decrypt", "value": 53.12994011976049}, {"lowerIsBetter": false, "replicates": [959.6928982725528], "unit": "score", "name": "RayTrace", "value": 771.0685379999996}, {"lowerIsBetter": false, "replicates": [553.7098560354374], "unit": "score", "name": "Earley", "value": 1203.6321779999998}, {"lowerIsBetter": false, "replicates": [10557.894736842105], "unit": "score", "name": "Boyer", "value": 63.12461116650046}, {"lowerIsBetter": false, "replicates": [24585.365853658535], "unit": "score", "name": "RegExp", "value": 37.05395337301591}, {"lowerIsBetter": false, "replicates": [529.6610169491526], "unit": "score", "name": "Splay", "value": 153.85500800000003}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 23174.043645864615}]} 02:03:23 INFO - RETURN: dromaeo_css: 7353.84 02:03:23 INFO - RETURN: kraken: 1463.70 02:03:23 INFO - RETURN: v8_7: 23174.04 02:03:23 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,53,35]]", "result": "23174.04"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,53,35]]", "result": "1463.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,53,35]]", "result": "7353.84"}}} 02:03:23 INFO - Return code: 0 02:03:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 02:03:23 INFO - # TBPL SUCCESS # 02:03:23 INFO - Running post-action listener: _resource_record_post_action 02:03:23 INFO - Running post-run listener: _resource_record_post_run 02:03:24 INFO - Total resource usage - Wall time: 1220s; CPU: 13.0%; Read bytes: 4096; Write bytes: 512081920; Read time: 16; Write time: 541632 02:03:24 INFO - install - Wall time: 14s; CPU: 15.0%; Read bytes: 0; Write bytes: 250335232; Read time: 0; Write time: 379452 02:03:24 INFO - run-tests - Wall time: 1206s; CPU: 13.0%; Read bytes: 4096; Write bytes: 261390336; Read time: 16; Write time: 162132 02:03:24 INFO - Running post-run listener: _upload_blobber_files 02:03:24 INFO - Blob upload gear active. 02:03:24 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 02:03:24 INFO - Copying logs to upload dir... 02:03:24 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1249.944433 ========= master_lag: 2.70 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2015-12-15 02:03:26.945415) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-15 02:03:26.948828) ========= 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=f5f5a079460e1a9be8676904000001c1-1450172538.96931-1797453487 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450155070/firefox-44.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009987 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450155070/firefox-44.0.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-15 02:03:26.982722) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 02:03:26.983086) ========= 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=f5f5a079460e1a9be8676904000001c1-1450172538.96931-1797453487 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004608 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 02:03:27.032531) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-15 02:03:27.032897) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-15 02:03:27.033243) ========= ========= Total master_lag: 2.89 =========