builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-056 starttime: 1451338046.39 results: success (0) buildid: 20151228110735 builduid: 4d2c6207a5054d7f9cc8f5c8a092a1e4 revision: a7e4b6ab821f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-28 13:27:26.392918) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-28 13:27:26.393315) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-28 13:27:26.393600) ========= 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=0ae9de487587ba4b94dd3100000001b5-1451337611.323402-376386351 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006425 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-28 13:27:26.422954) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-28 13:27:26.423267) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-28 13:27:26.496312) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 13:27:26.496672) ========= 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=0ae9de487587ba4b94dd3100000001b5-1451337611.323402-376386351 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004586 ========= master_lag: 0.34 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 13:27:26.844191) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-28 13:27:26.844526) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-28 13:27:26.844877) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 13:27:26.845145) ========= 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=0ae9de487587ba4b94dd3100000001b5-1451337611.323402-376386351 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-28 13:27:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 40.2M=0s 2015-12-28 13:27:27 (40.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.160135 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 13:27:27.043510) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 13:27:27.044102) ========= 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=0ae9de487587ba4b94dd3100000001b5-1451337611.323402-376386351 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017977 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 13:27:27.102878) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-28 13:27:27.103218) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev a7e4b6ab821f --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 a7e4b6ab821f --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=0ae9de487587ba4b94dd3100000001b5-1451337611.323402-376386351 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-28 13:27:27,199 Setting DEBUG logging. 2015-12-28 13:27:27,199 attempt 1/10 2015-12-28 13:27:27,199 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/a7e4b6ab821f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-28 13:27:28,384 unpacking tar archive at: mozilla-beta-a7e4b6ab821f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.441489 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-28 13:27:28.559547) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-28 13:27:28.559872) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-28 13:27:28.575190) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-28 13:27:28.575538) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-28 13:27:28.575950) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2015-12-28 13:27:28.576229) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0ae9de487587ba4b94dd3100000001b5-1451337611.323402-376386351 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:27:28 INFO - MultiFileLogger online at 20151228 13:27:28 in /builds/slave/test-pgo 13:27:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 13:27:28 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 13:27:28 INFO - {'append_to_log': False, 13:27:28 INFO - 'base_work_dir': '/builds/slave/test-pgo', 13:27:28 INFO - 'blob_upload_branch': 'Mozilla-Beta', 13:27:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 13:27:28 INFO - 'branch': 'Mozilla-Beta', 13:27:28 INFO - 'buildbot_json_path': 'buildprops.json', 13:27:28 INFO - 'config_files': ('talos/linux_config.py',), 13:27:28 INFO - 'default_actions': ('clobber', 13:27:28 INFO - 'read-buildbot-config', 13:27:28 INFO - 'download-and-extract', 13:27:28 INFO - 'populate-webroot', 13:27:28 INFO - 'create-virtualenv', 13:27:28 INFO - 'install', 13:27:28 INFO - 'run-tests'), 13:27:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:27:28 INFO - 'download_minidump_stackwalk': True, 13:27:28 INFO - 'download_symbols': 'ondemand', 13:27:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:27:28 INFO - 'tooltool.py': '/tools/tooltool.py', 13:27:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:27:28 INFO - '/tools/misc-python/virtualenv.py')}, 13:27:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:27:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:27:28 INFO - 'installer_path': 'installer.exe', 13:27:28 INFO - 'log_level': 'info', 13:27:28 INFO - 'log_name': 'talos', 13:27:28 INFO - 'log_to_console': True, 13:27:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:27:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:27:28 INFO - 'opt_config_files': (), 13:27:28 INFO - 'pip_index': False, 13:27:28 INFO - 'sps_profile': False, 13:27:28 INFO - 'sps_profile_interval': 0, 13:27:28 INFO - 'suite': 'dromaeojs', 13:27:28 INFO - 'system_bits': '32', 13:27:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:27:28 INFO - 'title': 'talos-linux64-ix-056', 13:27:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:27:28 INFO - 'use_talos_json': True, 13:27:28 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 13:27:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:27:28 INFO - 'work_dir': 'build'} 13:27:28 INFO - ##### 13:27:28 INFO - ##### Running clobber step. 13:27:28 INFO - ##### 13:27:28 INFO - Running pre-action listener: _resource_record_pre_action 13:27:28 INFO - Running main action method: clobber 13:27:28 INFO - rmtree: /builds/slave/test-pgo/build 13:27:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 13:27:29 INFO - Running post-action listener: _resource_record_post_action 13:27:29 INFO - ##### 13:27:29 INFO - ##### Running read-buildbot-config step. 13:27:29 INFO - ##### 13:27:29 INFO - Running pre-action listener: _resource_record_pre_action 13:27:29 INFO - Running main action method: read_buildbot_config 13:27:29 INFO - Using buildbot properties: 13:27:29 INFO - { 13:27:29 INFO - "properties": { 13:27:29 INFO - "buildnumber": 50, 13:27:29 INFO - "product": "firefox", 13:27:29 INFO - "script_repo_revision": "production", 13:27:29 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 13:27:29 INFO - "repository": "", 13:27:29 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 13:27:29 INFO - "buildid": "20151228110735", 13:27:29 INFO - "slavename": "talos-linux64-ix-056", 13:27:29 INFO - "pgo_build": "True", 13:27:29 INFO - "basedir": "/builds/slave/test-pgo", 13:27:29 INFO - "project": "", 13:27:29 INFO - "platform": "ubuntu64_hw", 13:27:29 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:27:29 INFO - "slavebuilddir": "test", 13:27:29 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 13:27:29 INFO - "branch": "mozilla-beta", 13:27:29 INFO - "repo_path": "releases/mozilla-beta", 13:27:29 INFO - "stage_platform": "linux64-pgo", 13:27:29 INFO - "builduid": "4d2c6207a5054d7f9cc8f5c8a092a1e4", 13:27:29 INFO - "revision": "a7e4b6ab821f" 13:27:29 INFO - }, 13:27:29 INFO - "sourcestamp": { 13:27:29 INFO - "repository": "", 13:27:29 INFO - "hasPatch": false, 13:27:29 INFO - "project": "", 13:27:29 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 13:27:29 INFO - "changes": [ 13:27:29 INFO - { 13:27:29 INFO - "category": null, 13:27:29 INFO - "files": [ 13:27:29 INFO - { 13:27:29 INFO - "url": null, 13:27:29 INFO - "name": "http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1451329655/firefox-44.0.en-US.linux-x86_64.tar.bz2" 13:27:29 INFO - } 13:27:29 INFO - ], 13:27:29 INFO - "repository": "", 13:27:29 INFO - "rev": "a7e4b6ab821f", 13:27:29 INFO - "who": "sendchange", 13:27:29 INFO - "when": 1451337989, 13:27:29 INFO - "number": 7397575, 13:27:29 INFO - "comments": "Bug 1200677 - Import navigation-redirect.https.html for non-e10s. r=jdm a=testonly", 13:27:29 INFO - "project": "", 13:27:29 INFO - "at": "Mon 28 Dec 2015 13:26:29", 13:27:29 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 13:27:29 INFO - "revlink": "", 13:27:29 INFO - "properties": [ 13:27:29 INFO - [ 13:27:29 INFO - "buildid", 13:27:29 INFO - "20151228110735", 13:27:29 INFO - "Change" 13:27:29 INFO - ], 13:27:29 INFO - [ 13:27:29 INFO - "builduid", 13:27:29 INFO - "4d2c6207a5054d7f9cc8f5c8a092a1e4", 13:27:29 INFO - "Change" 13:27:29 INFO - ], 13:27:29 INFO - [ 13:27:29 INFO - "pgo_build", 13:27:29 INFO - "True", 13:27:29 INFO - "Change" 13:27:29 INFO - ] 13:27:29 INFO - ], 13:27:29 INFO - "revision": "a7e4b6ab821f" 13:27:29 INFO - } 13:27:29 INFO - ], 13:27:29 INFO - "revision": "a7e4b6ab821f" 13:27:29 INFO - } 13:27:29 INFO - } 13:27:29 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1451329655/firefox-44.0.en-US.linux-x86_64.tar.bz2. 13:27:29 INFO - Running post-action listener: _resource_record_post_action 13:27:29 INFO - ##### 13:27:29 INFO - ##### Running download-and-extract step. 13:27:29 INFO - ##### 13:27:29 INFO - Running pre-action listener: _resource_record_pre_action 13:27:29 INFO - Running main action method: download_and_extract 13:27:29 INFO - mkdir: /builds/slave/test-pgo/build/tests 13:27:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:27:29 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1451329655/test_packages.json 13:27:29 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1451329655/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 13:27:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1451329655/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 13:27:29 INFO - Downloaded 1270 bytes. 13:27:29 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 13:27:29 INFO - Using the following test package requirements: 13:27:29 INFO - {u'common': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip'], 13:27:29 INFO - u'cppunittest': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 13:27:29 INFO - u'firefox-44.0.en-US.linux-x86_64.cppunittest.tests.zip'], 13:27:29 INFO - u'jittest': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 13:27:29 INFO - u'jsshell-linux-x86_64.zip'], 13:27:29 INFO - u'mochitest': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 13:27:29 INFO - u'firefox-44.0.en-US.linux-x86_64.mochitest.tests.zip'], 13:27:29 INFO - u'mozbase': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip'], 13:27:29 INFO - u'reftest': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 13:27:29 INFO - u'firefox-44.0.en-US.linux-x86_64.reftest.tests.zip'], 13:27:29 INFO - u'talos': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 13:27:29 INFO - u'firefox-44.0.en-US.linux-x86_64.talos.tests.zip'], 13:27:29 INFO - u'web-platform': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 13:27:29 INFO - u'firefox-44.0.en-US.linux-x86_64.web-platform.tests.zip'], 13:27:29 INFO - u'webapprt': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip'], 13:27:29 INFO - u'xpcshell': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 13:27:29 INFO - u'firefox-44.0.en-US.linux-x86_64.xpcshell.tests.zip']} 13:27:29 INFO - Downloading packages: [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:27:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:27:29 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1451329655/firefox-44.0.en-US.linux-x86_64.common.tests.zip 13:27:29 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1451329655/firefox-44.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip 13:27:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1451329655/firefox-44.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:27:34 INFO - Downloaded 22572188 bytes. 13:27:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 13:27:34 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip 13:27:34 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 13:27:35 INFO - Return code: 0 13:27:35 INFO - Downloading packages: [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', u'firefox-44.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 13:27:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:27:35 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1451329655/firefox-44.0.en-US.linux-x86_64.common.tests.zip 13:27:35 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1451329655/firefox-44.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip 13:27:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1451329655/firefox-44.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:27:35 INFO - Downloaded 22572188 bytes. 13:27: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 13:27:35 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip 13:27: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 13:27:37 INFO - Return code: 0 13:27:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:27:37 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1451329655/firefox-44.0.en-US.linux-x86_64.talos.tests.zip 13:27:37 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1451329655/firefox-44.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.talos.tests.zip 13:27:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1451329655/firefox-44.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:27:39 INFO - Downloaded 11131970 bytes. 13:27:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 13:27:39 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.talos.tests.zip 13:27:39 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 13:27:39 INFO - Return code: 0 13:27:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:27:39 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1451329655/firefox-44.0.en-US.linux-x86_64.tar.bz2 13:27:39 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1451329655/firefox-44.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.tar.bz2 13:27:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1451329655/firefox-44.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 13:27:45 INFO - Downloaded 56627324 bytes. 13:27:45 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1451329655/firefox-44.0.en-US.linux-x86_64.tar.bz2 13:27:45 INFO - mkdir: /builds/slave/test-pgo/properties 13:27:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 13:27:45 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 13:27:45 INFO - Contents: 13:27:45 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1451329655/firefox-44.0.en-US.linux-x86_64.tar.bz2 13:27:45 INFO - Running post-action listener: _resource_record_post_action 13:27:45 INFO - Running post-action listener: set_extra_try_arguments 13:27:45 INFO - ##### 13:27:45 INFO - ##### Running populate-webroot step. 13:27:45 INFO - ##### 13:27:45 INFO - Running pre-action listener: _resource_record_pre_action 13:27:45 INFO - Running main action method: populate_webroot 13:27:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:27:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:27:45 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 13:27:45 INFO - '../fennec_ids.txt'], 13:27:45 INFO - 'tests': ['tcheck2']}, 13:27:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:27:45 INFO - '--tppagecycles', 13:27:45 INFO - '7'], 13:27:45 INFO - 'tests': ['tsvgm']}}, 13:27:45 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 13:27:45 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 13:27:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:27:45 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:27:45 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 13:27:45 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:27:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:27:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:27:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:27:45 INFO - 'talos_options': ['--e10s'], 13:27:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:27:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:27:45 INFO - 'tests': ['damp', 'tps']}, 13:27:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:27:45 INFO - 'talos_options': ['--e10s'], 13:27:45 INFO - 'tests': ['damp', 'tps']}, 13:27:45 INFO - 'g3': {'tests': ['dromaeo_dom']}, 13:27:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:27:45 INFO - 'other': {'tests': ['a11yr', 13:27:45 INFO - 'ts_paint', 13:27:45 INFO - 'tpaint', 13:27:45 INFO - 'sessionrestore', 13:27:45 INFO - 'sessionrestore_no_auto_restore']}, 13:27:45 INFO - 'other-e10s': {'talos_options': ['--e10s'], 13:27:45 INFO - 'tests': ['a11yr', 13:27:45 INFO - 'ts_paint', 13:27:45 INFO - 'tpaint', 13:27:45 INFO - 'sessionrestore', 13:27:45 INFO - 'sessionrestore_no_auto_restore']}, 13:27:45 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 13:27:45 INFO - 'tests': ['a11yr', 13:27:45 INFO - 'ts_paint', 13:27:45 INFO - 'tpaint', 13:27:45 INFO - 'sessionrestore', 13:27:45 INFO - 'sessionrestore_no_auto_restore']}, 13:27:45 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 13:27:45 INFO - 'tests': ['a11yr', 13:27:45 INFO - 'ts_paint', 13:27:45 INFO - 'tpaint', 13:27:45 INFO - 'sessionrestore', 13:27:45 INFO - 'sessionrestore_no_auto_restore']}, 13:27:45 INFO - 'other_l64': {'tests': ['a11yr', 13:27:45 INFO - 'ts_paint', 13:27:45 INFO - 'tpaint', 13:27:45 INFO - 'sessionrestore', 13:27:45 INFO - 'sessionrestore_no_auto_restore']}, 13:27:45 INFO - 'other_nol64': {'tests': ['a11yr', 13:27:45 INFO - 'ts_paint', 13:27:45 INFO - 'tpaint', 13:27:45 INFO - 'sessionrestore', 13:27:45 INFO - 'sessionrestore_no_auto_restore']}, 13:27:45 INFO - 'svgr': {'tests': ['tsvgx', 13:27:45 INFO - 'tsvgr_opacity', 13:27:45 INFO - 'tart', 13:27:45 INFO - 'tscrollx', 13:27:45 INFO - 'cart']}, 13:27:45 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 13:27:45 INFO - 'tests': ['tsvgx', 13:27:45 INFO - 'tsvgr_opacity', 13:27:45 INFO - 'tart', 13:27:45 INFO - 'tscrollx', 13:27:45 INFO - 'cart']}, 13:27:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:27:45 INFO - 'tests': ['tp5o']}, 13:27:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:27:45 INFO - 'talos_options': ['--e10s'], 13:27:45 INFO - 'tests': ['tp5o']}, 13:27:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:27:45 INFO - 'talos_options': ['--xperf_path', 13:27:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:27:45 INFO - 'tests': ['tp5n']}, 13:27:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:27:45 INFO - 'talos_options': ['--e10s', 13:27:45 INFO - '--xperf_path', 13:27:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:27:45 INFO - 'tests': ['tp5n']}}, 13:27:45 INFO - 'talos.zip': {'path': '', 13:27:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:27:45 INFO - Running post-action listener: _resource_record_post_action 13:27:45 INFO - ##### 13:27:45 INFO - ##### Running create-virtualenv step. 13:27:45 INFO - ##### 13:27:45 INFO - Running pre-action listener: _resource_record_pre_action 13:27:45 INFO - Running main action method: create_virtualenv 13:27:45 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 13:27:45 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 13:27:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 13:27:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:27:45 INFO - Using real prefix '/usr' 13:27:45 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 13:27:46 INFO - Installing distribute.............................................................................................................................................................................................done. 13:27:49 INFO - Installing pip.................done. 13:27:49 INFO - Return code: 0 13:27:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 13:27:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:27:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:27:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:27:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:27:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:49 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 0x7f3b3c799f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef0600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7f350>, '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 0xf80250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf806e0>, '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': '0ae9de487587ba4b94dd3100000001b5-1451337611.323402-376386351', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:27:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 13:27:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:27:49 INFO - Using env: {'DISPLAY': ':0', 13:27:49 INFO - 'HOME': '/home/cltbld', 13:27:49 INFO - 'LANG': 'en_US.UTF-8', 13:27:49 INFO - 'LANGUAGE': 'en_US:en', 13:27:49 INFO - 'LOGNAME': 'cltbld', 13:27:49 INFO - 'MAIL': '/var/mail/cltbld', 13:27:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:27:49 INFO - 'MOZ_NO_REMOTE': '1', 13:27:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:27:49 INFO - 'NO_EM_RESTART': '1', 13:27:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:27:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:27:49 INFO - 'PWD': '/builds/slave/test-pgo', 13:27:49 INFO - 'SHELL': '/bin/bash', 13:27:49 INFO - 'SHLVL': '1', 13:27:49 INFO - 'TERM': 'linux', 13:27:49 INFO - 'TMOUT': '86400', 13:27:49 INFO - 'USER': 'cltbld', 13:27:49 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1451337611.323402-376386351', 13:27:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:27:49 INFO - '_': '/tools/buildbot/bin/python'} 13:27:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:27:50 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 13:27:50 INFO - Cleaning up... 13:27:50 INFO - Return code: 0 13:27:50 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 13:27: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')]} 13:27:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:27:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27: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')]} 13:27:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:27:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:50 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 0x7f3b3c799f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef0600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7f350>, '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 0xf80250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf806e0>, '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': '0ae9de487587ba4b94dd3100000001b5-1451337611.323402-376386351', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:27:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 13:27:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 13:27:50 INFO - Using env: {'DISPLAY': ':0', 13:27:50 INFO - 'HOME': '/home/cltbld', 13:27:50 INFO - 'LANG': 'en_US.UTF-8', 13:27:50 INFO - 'LANGUAGE': 'en_US:en', 13:27:50 INFO - 'LOGNAME': 'cltbld', 13:27:50 INFO - 'MAIL': '/var/mail/cltbld', 13:27:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:27:50 INFO - 'MOZ_NO_REMOTE': '1', 13:27:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:27:50 INFO - 'NO_EM_RESTART': '1', 13:27:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:27:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:27:50 INFO - 'PWD': '/builds/slave/test-pgo', 13:27:50 INFO - 'SHELL': '/bin/bash', 13:27:50 INFO - 'SHLVL': '1', 13:27:50 INFO - 'TERM': 'linux', 13:27:50 INFO - 'TMOUT': '86400', 13:27:50 INFO - 'USER': 'cltbld', 13:27:50 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1451337611.323402-376386351', 13:27:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:27:50 INFO - '_': '/tools/buildbot/bin/python'} 13:27:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:27:50 INFO - Downloading/unpacking psutil>=0.7.1 13:27:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:27:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:27:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:27:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:27:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:27:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:27:51 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 13:27:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 13:27:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 13:27:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:27:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:27:52 INFO - Installing collected packages: psutil 13:27:52 INFO - Running setup.py install for psutil 13:27:52 INFO - building 'psutil._psutil_linux' extension 13:27:52 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 13:27:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 13:27:52 INFO - building 'psutil._psutil_posix' extension 13:27:52 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 13:27:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 13:27:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:27:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:27:52 INFO - Successfully installed psutil 13:27:52 INFO - Cleaning up... 13:27:52 INFO - Return code: 0 13:27:52 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 13:27:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:27:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:27:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:27:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:27:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:52 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 0x7f3b3c799f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef0600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7f350>, '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 0xf80250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf806e0>, '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': '0ae9de487587ba4b94dd3100000001b5-1451337611.323402-376386351', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:27:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 13:27:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 13:27:52 INFO - Using env: {'DISPLAY': ':0', 13:27:52 INFO - 'HOME': '/home/cltbld', 13:27:52 INFO - 'LANG': 'en_US.UTF-8', 13:27:52 INFO - 'LANGUAGE': 'en_US:en', 13:27:52 INFO - 'LOGNAME': 'cltbld', 13:27:52 INFO - 'MAIL': '/var/mail/cltbld', 13:27:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:27:52 INFO - 'MOZ_NO_REMOTE': '1', 13:27:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:27:52 INFO - 'NO_EM_RESTART': '1', 13:27:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:27:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:27:52 INFO - 'PWD': '/builds/slave/test-pgo', 13:27:52 INFO - 'SHELL': '/bin/bash', 13:27:52 INFO - 'SHLVL': '1', 13:27:52 INFO - 'TERM': 'linux', 13:27:52 INFO - 'TMOUT': '86400', 13:27:52 INFO - 'USER': 'cltbld', 13:27:52 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1451337611.323402-376386351', 13:27:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:27:52 INFO - '_': '/tools/buildbot/bin/python'} 13:27:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:27:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:27:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:27:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:27:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:27:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:27:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:27:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:27:54 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:27:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 13:27:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:27:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:27:54 INFO - Installing collected packages: mozsystemmonitor 13:27:54 INFO - Running setup.py install for mozsystemmonitor 13:27:54 INFO - Successfully installed mozsystemmonitor 13:27:54 INFO - Cleaning up... 13:27:54 INFO - Return code: 0 13:27:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 13:27:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:27:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:27:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:27:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:27:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:54 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3b3c799f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef0600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7f350>, '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 0xf80250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf806e0>, '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': '0ae9de487587ba4b94dd3100000001b5-1451337611.323402-376386351', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:27:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 13:27:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:27:54 INFO - Using env: {'DISPLAY': ':0', 13:27:54 INFO - 'HOME': '/home/cltbld', 13:27:54 INFO - 'LANG': 'en_US.UTF-8', 13:27:54 INFO - 'LANGUAGE': 'en_US:en', 13:27:54 INFO - 'LOGNAME': 'cltbld', 13:27:54 INFO - 'MAIL': '/var/mail/cltbld', 13:27:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:27:54 INFO - 'MOZ_NO_REMOTE': '1', 13:27:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:27:54 INFO - 'NO_EM_RESTART': '1', 13:27:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:27:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:27:54 INFO - 'PWD': '/builds/slave/test-pgo', 13:27:54 INFO - 'SHELL': '/bin/bash', 13:27:54 INFO - 'SHLVL': '1', 13:27:54 INFO - 'TERM': 'linux', 13:27:54 INFO - 'TMOUT': '86400', 13:27:54 INFO - 'USER': 'cltbld', 13:27:54 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1451337611.323402-376386351', 13:27:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:27:54 INFO - '_': '/tools/buildbot/bin/python'} 13:27:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:27:55 INFO - Downloading/unpacking blobuploader==1.2.4 13:27: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 13:27: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 13:27: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 13:27: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 13:27: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 13:27: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 13:27:56 INFO - Downloading blobuploader-1.2.4.tar.gz 13:27:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 13:27:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:27:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:27:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:27:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:27:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:27:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:27:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:27:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:27:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 13:27:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 13:27:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:27: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 13:27: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 13:27: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 13:27: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 13:27: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 13:27: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 13:27:57 INFO - Downloading docopt-0.6.1.tar.gz 13:27:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 13:27:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 13:27:57 INFO - Installing collected packages: blobuploader, requests, docopt 13:27:57 INFO - Running setup.py install for blobuploader 13:27:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:27:57 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 13:27:57 INFO - Running setup.py install for requests 13:27:57 INFO - Running setup.py install for docopt 13:27:58 INFO - Successfully installed blobuploader requests docopt 13:27:58 INFO - Cleaning up... 13:27:58 INFO - Return code: 0 13:27:58 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:27:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:27:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:27:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:27:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:27:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:58 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 0x7f3b3c799f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef0600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7f350>, '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 0xf80250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf806e0>, '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': '0ae9de487587ba4b94dd3100000001b5-1451337611.323402-376386351', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:27:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 13:27:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:27:58 INFO - Using env: {'DISPLAY': ':0', 13:27:58 INFO - 'HOME': '/home/cltbld', 13:27:58 INFO - 'LANG': 'en_US.UTF-8', 13:27:58 INFO - 'LANGUAGE': 'en_US:en', 13:27:58 INFO - 'LOGNAME': 'cltbld', 13:27:58 INFO - 'MAIL': '/var/mail/cltbld', 13:27:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:27:58 INFO - 'MOZ_NO_REMOTE': '1', 13:27:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:27:58 INFO - 'NO_EM_RESTART': '1', 13:27:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:27:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:27:58 INFO - 'PWD': '/builds/slave/test-pgo', 13:27:58 INFO - 'SHELL': '/bin/bash', 13:27:58 INFO - 'SHLVL': '1', 13:27:58 INFO - 'TERM': 'linux', 13:27:58 INFO - 'TMOUT': '86400', 13:27:58 INFO - 'USER': 'cltbld', 13:27:58 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1451337611.323402-376386351', 13:27:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:27:58 INFO - '_': '/tools/buildbot/bin/python'} 13:27:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:27:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:27:58 INFO - Running setup.py (path:/tmp/pip-pHU0kY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:27:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:27:58 INFO - Running setup.py (path:/tmp/pip-VV65Zk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:27:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:27:58 INFO - Running setup.py (path:/tmp/pip-typMt8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:27:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:27:58 INFO - Running setup.py (path:/tmp/pip-QgIIOC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:27:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 13:27:58 INFO - Running setup.py (path:/tmp/pip-jeWwGp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 13:27:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:27:58 INFO - Running setup.py (path:/tmp/pip-eFHHmG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:27:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:27:58 INFO - Running setup.py (path:/tmp/pip-C8o5ya-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:27:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:27:58 INFO - Running setup.py (path:/tmp/pip-fW6LtR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:27:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 13:27:58 INFO - Running setup.py (path:/tmp/pip-JkrJyU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 13:27:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 13:27:58 INFO - Running setup.py (path:/tmp/pip-YE8Zrx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 13:27:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:27:58 INFO - Running setup.py (path:/tmp/pip-8V82o0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:27:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:27:59 INFO - Running setup.py (path:/tmp/pip-0Nob_f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:27:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:27:59 INFO - Running setup.py (path:/tmp/pip-4b11CS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:27:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:27:59 INFO - Running setup.py (path:/tmp/pip-YoufJI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:27:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:27:59 INFO - Running setup.py (path:/tmp/pip-lfsT1u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:27:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 13:27:59 INFO - Running setup.py (path:/tmp/pip-cEI4mQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 13:27:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 13:27:59 INFO - Running setup.py (path:/tmp/pip-IQrhZG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 13:27:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:27:59 INFO - Running setup.py install for manifestparser 13:27:59 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 13:27:59 INFO - Running setup.py install for mozcrash 13:27:59 INFO - Running setup.py install for mozdebug 13:27:59 INFO - Running setup.py install for mozdevice 13:27:59 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 13:27:59 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 13:27:59 INFO - Running setup.py install for mozfile 13:28:00 INFO - Running setup.py install for mozhttpd 13:28:00 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 13:28:00 INFO - Running setup.py install for mozinfo 13:28:00 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 13:28:00 INFO - Running setup.py install for mozInstall 13:28:00 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 13:28:00 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 13:28:00 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 13:28:00 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 13:28:00 INFO - Running setup.py install for mozleak 13:28:00 INFO - Running setup.py install for mozlog 13:28:00 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 13:28:00 INFO - Running setup.py install for moznetwork 13:28:00 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 13:28:00 INFO - Running setup.py install for mozprocess 13:28:00 INFO - Running setup.py install for mozprofile 13:28:00 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 13:28:00 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 13:28:00 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 13:28:00 INFO - Running setup.py install for mozrunner 13:28:00 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 13:28:00 INFO - Running setup.py install for mozscreenshot 13:28:01 INFO - Running setup.py install for moztest 13:28:01 INFO - Running setup.py install for mozversion 13:28:01 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 13:28:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:28:01 INFO - Cleaning up... 13:28:01 INFO - Return code: 0 13:28:01 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:28:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:28:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:28:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:28:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:28:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:28:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:28:01 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 0x7f3b3c799f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef0600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7f350>, '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 0xf80250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf806e0>, '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': '0ae9de487587ba4b94dd3100000001b5-1451337611.323402-376386351', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:28:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 13:28:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:28:01 INFO - Using env: {'DISPLAY': ':0', 13:28:01 INFO - 'HOME': '/home/cltbld', 13:28:01 INFO - 'LANG': 'en_US.UTF-8', 13:28:01 INFO - 'LANGUAGE': 'en_US:en', 13:28:01 INFO - 'LOGNAME': 'cltbld', 13:28:01 INFO - 'MAIL': '/var/mail/cltbld', 13:28:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:28:01 INFO - 'MOZ_NO_REMOTE': '1', 13:28:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:28:01 INFO - 'NO_EM_RESTART': '1', 13:28:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:28:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:28:01 INFO - 'PWD': '/builds/slave/test-pgo', 13:28:01 INFO - 'SHELL': '/bin/bash', 13:28:01 INFO - 'SHLVL': '1', 13:28:01 INFO - 'TERM': 'linux', 13:28:01 INFO - 'TMOUT': '86400', 13:28:01 INFO - 'USER': 'cltbld', 13:28:01 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1451337611.323402-376386351', 13:28:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:28:01 INFO - '_': '/tools/buildbot/bin/python'} 13:28:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:28:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:28:01 INFO - Running setup.py (path:/tmp/pip-rlehz8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:28:01 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 13:28:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:28:01 INFO - Running setup.py (path:/tmp/pip-I1ZlK9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:28:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 13:28:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:28:01 INFO - Running setup.py (path:/tmp/pip-ORlSg_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:28:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 13:28:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:28:01 INFO - Running setup.py (path:/tmp/pip-k0Nnde-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:28:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.46 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 13:28:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 13:28:01 INFO - Running setup.py (path:/tmp/pip-Ewz9Xt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 13:28:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 13:28:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:28:01 INFO - Running setup.py (path:/tmp/pip-BOTR_q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:28:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 13:28:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:28:01 INFO - Running setup.py (path:/tmp/pip-3TMTd5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:28:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.8 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 13:28:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:28:01 INFO - Running setup.py (path:/tmp/pip-0dTsPC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:28:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 13:28:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 13:28:02 INFO - Running setup.py (path:/tmp/pip-UhmPfR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 13:28:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 13:28:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 13:28:02 INFO - Running setup.py (path:/tmp/pip-s2b2HH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 13:28:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 13:28:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:28:02 INFO - Running setup.py (path:/tmp/pip-r8yP5K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:28:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 13:28:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:28:02 INFO - Running setup.py (path:/tmp/pip-ySh1y5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:28:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 13:28:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:28:02 INFO - Running setup.py (path:/tmp/pip-0B38un-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:28:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 13:28:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:28:02 INFO - Running setup.py (path:/tmp/pip-yWl4zB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:28:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 13:28:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:28:02 INFO - Running setup.py (path:/tmp/pip-3SInaN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:28:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 13:28:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 13:28:02 INFO - Running setup.py (path:/tmp/pip-m8bQeY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 13:28:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 13:28:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 13:28:02 INFO - Running setup.py (path:/tmp/pip-iBcWAJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 13:28:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 13:28:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 13:28:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 13:28:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 13:28:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.46->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 13:28:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.46->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 13:28:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 13:28:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:28:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:28:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:28:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:28:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:28:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:28:04 INFO - Downloading blessings-1.5.1.tar.gz 13:28:04 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 13:28:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 13:28:04 INFO - Installing collected packages: blessings 13:28:04 INFO - Running setup.py install for blessings 13:28:04 INFO - Successfully installed blessings 13:28:04 INFO - Cleaning up... 13:28:04 INFO - Return code: 0 13:28:04 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 13:28:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 13:28:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 13:28:04 INFO - Reading from file tmpfile_stdout 13:28:04 INFO - Current package versions: 13:28:04 INFO - argparse == 1.2.1 13:28:04 INFO - blessings == 1.5.1 13:28:04 INFO - blobuploader == 1.2.4 13:28:04 INFO - docopt == 0.6.1 13:28:04 INFO - manifestparser == 1.1 13:28:04 INFO - mozInstall == 1.12 13:28:04 INFO - mozcrash == 0.16 13:28:04 INFO - mozdebug == 0.1 13:28:04 INFO - mozdevice == 0.46 13:28:04 INFO - mozfile == 1.2 13:28:04 INFO - mozhttpd == 0.7 13:28:04 INFO - mozinfo == 0.8 13:28:04 INFO - mozleak == 0.1 13:28:04 INFO - mozlog == 3.0 13:28:04 INFO - moznetwork == 0.27 13:28:04 INFO - mozprocess == 0.22 13:28:04 INFO - mozprofile == 0.27 13:28:04 INFO - mozrunner == 6.11 13:28:04 INFO - mozscreenshot == 0.1 13:28:04 INFO - mozsystemmonitor == 0.0 13:28:04 INFO - moztest == 0.7 13:28:04 INFO - mozversion == 1.4 13:28:04 INFO - psutil == 3.1.1 13:28:04 INFO - requests == 1.2.3 13:28:04 INFO - wsgiref == 0.1.2 13:28:04 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:28:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:28:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:28:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:28:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:28:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:28:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:28:04 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f3b3c799f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef0600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7f350>, '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 0xf80250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf806e0>, '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': '0ae9de487587ba4b94dd3100000001b5-1451337611.323402-376386351', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:28:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 13:28:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:28:04 INFO - Using env: {'DISPLAY': ':0', 13:28:04 INFO - 'HOME': '/home/cltbld', 13:28:04 INFO - 'LANG': 'en_US.UTF-8', 13:28:04 INFO - 'LANGUAGE': 'en_US:en', 13:28:04 INFO - 'LOGNAME': 'cltbld', 13:28:04 INFO - 'MAIL': '/var/mail/cltbld', 13:28:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:28:04 INFO - 'MOZ_NO_REMOTE': '1', 13:28:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:28:04 INFO - 'NO_EM_RESTART': '1', 13:28:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:28:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:28:04 INFO - 'PWD': '/builds/slave/test-pgo', 13:28:04 INFO - 'SHELL': '/bin/bash', 13:28:04 INFO - 'SHLVL': '1', 13:28:04 INFO - 'TERM': 'linux', 13:28:04 INFO - 'TMOUT': '86400', 13:28:04 INFO - 'USER': 'cltbld', 13:28:04 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1451337611.323402-376386351', 13:28:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:28:04 INFO - '_': '/tools/buildbot/bin/python'} 13:28:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:28:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 13:28:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 13:28:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 13:28:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 13:28:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 13:28:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 13:28:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 13:28:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 13:28:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 13:28:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 13:28:05 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 13:28:05 INFO - Cleaning up... 13:28:05 INFO - Return code: 0 13:28:05 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 13:28:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:28:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:28:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:28:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:28:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:28:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:28:05 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3b3c799f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef0600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7f350>, '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 0xf80250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf806e0>, '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': '0ae9de487587ba4b94dd3100000001b5-1451337611.323402-376386351', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:28:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 13:28:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:28:05 INFO - Using env: {'DISPLAY': ':0', 13:28:05 INFO - 'HOME': '/home/cltbld', 13:28:05 INFO - 'LANG': 'en_US.UTF-8', 13:28:05 INFO - 'LANGUAGE': 'en_US:en', 13:28:05 INFO - 'LOGNAME': 'cltbld', 13:28:05 INFO - 'MAIL': '/var/mail/cltbld', 13:28:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:28:05 INFO - 'MOZ_NO_REMOTE': '1', 13:28:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:28:05 INFO - 'NO_EM_RESTART': '1', 13:28:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:28:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:28:05 INFO - 'PWD': '/builds/slave/test-pgo', 13:28:05 INFO - 'SHELL': '/bin/bash', 13:28:05 INFO - 'SHLVL': '1', 13:28:05 INFO - 'TERM': 'linux', 13:28:05 INFO - 'TMOUT': '86400', 13:28:05 INFO - 'USER': 'cltbld', 13:28:05 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1451337611.323402-376386351', 13:28:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:28:05 INFO - '_': '/tools/buildbot/bin/python'} 13:28:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:28:05 INFO - Downloading/unpacking jsonschema 13:28:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:28:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:28:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:28:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:28:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:28:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:28:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:28:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 13:28:07 INFO - Downloading/unpacking functools32 (from jsonschema) 13:28:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:28:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:28:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:28:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:28:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:28:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:28:07 INFO - Downloading functools32-3.2.3-2.tar.gz 13:28:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 13:28:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 13:28:07 INFO - warning: no files found matching '*.txt' 13:28:07 INFO - no previously-included directories found matching 'build' 13:28:07 INFO - no previously-included directories found matching 'dist' 13:28:07 INFO - no previously-included directories found matching '.git*' 13:28:07 INFO - Installing collected packages: jsonschema, functools32 13:28:07 INFO - Running setup.py install for functools32 13:28:07 INFO - warning: no files found matching '*.txt' 13:28:07 INFO - no previously-included directories found matching 'build' 13:28:07 INFO - no previously-included directories found matching 'dist' 13:28:07 INFO - no previously-included directories found matching '.git*' 13:28:07 INFO - Successfully installed jsonschema functools32 13:28:07 INFO - Cleaning up... 13:28:07 INFO - Return code: 0 13:28:07 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 13:28:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:28:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:28:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:28:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:28:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:28:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:28:07 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3b3c799f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef0600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7f350>, '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 0xf80250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf806e0>, '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': '0ae9de487587ba4b94dd3100000001b5-1451337611.323402-376386351', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:28:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 13:28:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 13:28:07 INFO - Using env: {'DISPLAY': ':0', 13:28:07 INFO - 'HOME': '/home/cltbld', 13:28:07 INFO - 'LANG': 'en_US.UTF-8', 13:28:07 INFO - 'LANGUAGE': 'en_US:en', 13:28:07 INFO - 'LOGNAME': 'cltbld', 13:28:07 INFO - 'MAIL': '/var/mail/cltbld', 13:28:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:28:07 INFO - 'MOZ_NO_REMOTE': '1', 13:28:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:28:07 INFO - 'NO_EM_RESTART': '1', 13:28:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:28:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:28:07 INFO - 'PWD': '/builds/slave/test-pgo', 13:28:07 INFO - 'SHELL': '/bin/bash', 13:28:07 INFO - 'SHLVL': '1', 13:28:07 INFO - 'TERM': 'linux', 13:28:07 INFO - 'TMOUT': '86400', 13:28:07 INFO - 'USER': 'cltbld', 13:28:07 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1451337611.323402-376386351', 13:28:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:28:07 INFO - '_': '/tools/buildbot/bin/python'} 13:28:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:28:07 INFO - Downloading/unpacking flake8 13:28:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:28:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:28:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:28:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:28:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:28:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:28:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:28:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 13:28:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:28:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:28:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:28:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:28:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:28:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:28:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:28:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:28:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 13:28:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:28:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:28:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:28:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:28:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:28:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:28:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:28:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 13:28:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:28:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:28:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:28:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:28:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:28:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:28:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:28:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 13:28:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 13:28:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:28:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:28:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:28:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:28:10 INFO - no previously-included directories found matching 'docs/_build' 13:28:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:28:10 INFO - Running setup.py install for pep8 13:28:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:28:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:28:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:28:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:28:10 INFO - no previously-included directories found matching 'docs/_build' 13:28:10 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 13:28:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:28:10 INFO - Cleaning up... 13:28:10 INFO - Return code: 0 13:28:10 INFO - Running post-action listener: _resource_record_post_action 13:28:10 INFO - Running post-action listener: _start_resource_monitoring 13:28:10 INFO - Starting resource monitoring. 13:28:10 INFO - ##### 13:28:10 INFO - ##### Running install step. 13:28:10 INFO - ##### 13:28:10 INFO - Running pre-action listener: _resource_record_pre_action 13:28:10 INFO - Running main action method: install 13:28:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 13:28:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 13:28:10 INFO - Reading from file tmpfile_stdout 13:28:10 INFO - Detecting whether we're running mozinstall >=1.0... 13:28:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 13:28:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 13:28:10 INFO - Reading from file tmpfile_stdout 13:28:10 INFO - Output received: 13:28:10 INFO - Usage: mozinstall [options] installer 13:28:10 INFO - Options: 13:28:10 INFO - -h, --help show this help message and exit 13:28:10 INFO - -d DEST, --destination=DEST 13:28:10 INFO - Directory to install application into. [default: 13:28:10 INFO - "/builds/slave/test-pgo"] 13:28:10 INFO - --app=APP Application being installed. [default: firefox] 13:28:10 INFO - mkdir: /builds/slave/test-pgo/build/application 13:28:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 13:28:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 13:28:24 INFO - Reading from file tmpfile_stdout 13:28:24 INFO - Output received: 13:28:24 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 13:28:24 INFO - Running post-action listener: _resource_record_post_action 13:28:24 INFO - ##### 13:28:24 INFO - ##### Running run-tests step. 13:28:24 INFO - ##### 13:28:24 INFO - Running pre-action listener: _resource_record_pre_action 13:28:24 INFO - Running main action method: run_tests 13:28:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 13:28:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 13:28:24 INFO - Python 2.7.3 13:28:24 INFO - Return code: 0 13:28:24 INFO - grabbing minidump binary from tooltool 13:28:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:28:24 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 0xf7f350>, '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 0xf80250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf806e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 13:28:24 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 13:28:24 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 13:28:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:28:24 INFO - Return code: 0 13:28:24 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 13:28:24 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 13:28:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 13:28:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 13:28:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 13:28:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 13:28:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 13:28:25 INFO - Return code: 0 13:28:25 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/1451329655/firefox-44.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 13:28:25 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/1451329655/firefox-44.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-056 --webServer localhost 13:28:25 INFO - Using env: {'DISPLAY': ':0', 13:28:25 INFO - 'HOME': '/home/cltbld', 13:28:25 INFO - 'LANG': 'en_US.UTF-8', 13:28:25 INFO - 'LANGUAGE': 'en_US:en', 13:28:25 INFO - 'LOGNAME': 'cltbld', 13:28:25 INFO - 'MAIL': '/var/mail/cltbld', 13:28:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 13:28:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 13:28:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:28:25 INFO - 'MOZ_NO_REMOTE': '1', 13:28:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 13:28:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:28:25 INFO - 'NO_EM_RESTART': '1', 13:28:25 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:28:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:28:25 INFO - 'PWD': '/builds/slave/test-pgo', 13:28:25 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 13:28:25 INFO - 'SHELL': '/bin/bash', 13:28:25 INFO - 'SHLVL': '1', 13:28:25 INFO - 'TERM': 'linux', 13:28:25 INFO - 'TMOUT': '86400', 13:28:25 INFO - 'USER': 'cltbld', 13:28:25 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1451337611.323402-376386351', 13:28:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:28:25 INFO - '_': '/tools/buildbot/bin/python'} 13:28:25 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/1451329655/firefox-44.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--webServer', 'localhost'] with output_timeout 3600 13:28:25 INFO - mozversion INFO | application_buildid: 20151228110735 13:28:25 INFO - mozversion INFO | application_changeset: a7e4b6ab821f03dba1d7b9b810e5604456722ba7 13:28:25 INFO - mozversion INFO | application_display_name: Nightly 13:28:25 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:28:25 INFO - mozversion INFO | application_name: Firefox 13:28:25 INFO - mozversion INFO | application_remotingname: firefox 13:28:25 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-beta 13:28:25 INFO - mozversion INFO | application_vendor: Mozilla 13:28:25 INFO - mozversion INFO | application_version: 44.0 13:28:25 INFO - mozversion INFO | platform_buildid: 20151228110735 13:28:25 INFO - mozversion INFO | platform_changeset: a7e4b6ab821f03dba1d7b9b810e5604456722ba7 13:28:25 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-beta 13:28:25 INFO - mozversion INFO | platform_version: 44.0 13:28:25 INFO - 2015-12-28 13:28:25,993 DEBUG : using testdate: 1451338105 13:28:25 INFO - 2015-12-28 13:28:25,993 DEBUG : actual date: 1451338105 13:28:26 INFO - 2015-12-28 13:28:26,001 INFO : starting webserver on 'localhost:57427' 13:28:26 INFO - 2015-12-28 13:28:26,002 INFO : Starting test suite talos-linux64-ix-056 13:28:26 INFO - 2015-12-28 13:28:26,002 INFO : Starting test dromaeo_css 13:28:26 INFO - 2015-12-28 13:28:26,002 DEBUG : operating with platform_type : linux_ 13:28:26 INFO - 2015-12-28 13:28:26,003 INFO : Initialising browser for dromaeo_css test... 13:28:26 INFO - 2015-12-28 13:28:26,018 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMupbjH/profile http://localhost:57427/getInfo.html 13:28:30 INFO - 2015-12-28 13:28:30,258 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:28:30 INFO - 2015-12-28 13:28:30,258 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:28:30 INFO - 2015-12-28 13:28:30,258 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 13:28:30 INFO - 2015-12-28 13:28:30,258 DEBUG : BROWSER_OUTPUT: __metrics 13:28:30 INFO - 2015-12-28 13:28:30,440 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:28:31 INFO - 2015-12-28 13:28:31,609 INFO : Browser initialized. 13:28:31 INFO - 2015-12-28 13:28:31,610 INFO : Running cycle 1/1 for dromaeo_css test... 13:28:31 INFO - 2015-12-28 13:28:31,610 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMupbjH/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:28:43 INFO - 2015-12-28 13:28:43,194 DEBUG : BROWSER_OUTPUT: RSS: Main: 129163264 13:28:43 INFO - 2015-12-28 13:28:43,194 DEBUG : BROWSER_OUTPUT: 13:29:33 INFO - 2015-12-28 13:29:33,914 DEBUG : BROWSER_OUTPUT: 1451338173909 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 13:31:42 INFO - 2015-12-28 13:31:42,277 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57427/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57427/tests/dromaeo/cssquery-ext.html) 13:31:43 INFO - 2015-12-28 13:31:43,321 DEBUG : BROWSER_OUTPUT: RSS: Main: 235864064 13:31:43 INFO - 2015-12-28 13:31:43,321 DEBUG : BROWSER_OUTPUT: 13:34:45 INFO - 2015-12-28 13:34:45,367 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57427/tests/dromaeo/cssquery-ext.html (next: http://localhost:57427/tests/dromaeo/cssquery-jquery.html) 13:34:45 INFO - 2015-12-28 13:34:45,928 DEBUG : BROWSER_OUTPUT: RSS: Main: 212856832 13:34:45 INFO - 2015-12-28 13:34:45,928 DEBUG : BROWSER_OUTPUT: 13:37:47 INFO - 2015-12-28 13:37:47,643 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57427/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57427/tests/dromaeo/cssquery-mootools.html) 13:37:48 INFO - 2015-12-28 13:37:48,204 DEBUG : BROWSER_OUTPUT: RSS: Main: 207421440 13:37:48 INFO - 2015-12-28 13:37:48,205 DEBUG : BROWSER_OUTPUT: 13:40:49 INFO - 2015-12-28 13:40:49,911 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57427/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57427/tests/dromaeo/cssquery-prototype.html) 13:40:50 INFO - 2015-12-28 13:40:50,480 DEBUG : BROWSER_OUTPUT: RSS: Main: 193208320 13:40:50 INFO - 2015-12-28 13:40:50,480 DEBUG : BROWSER_OUTPUT: 13:43:52 INFO - 2015-12-28 13:43:52,807 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57427/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57427/tests/dromaeo/cssquery-yui.html) 13:43:53 INFO - 2015-12-28 13:43:53,377 DEBUG : BROWSER_OUTPUT: RSS: Main: 192466944 13:43:53 INFO - 2015-12-28 13:43:53,377 DEBUG : BROWSER_OUTPUT: 13:46:55 INFO - 2015-12-28 13:46:55,380 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57427/tests/dromaeo/cssquery-yui.html (next: http://localhost:57427/tests/dromaeo/cssquery-dojo.html) 13:46:55 INFO - 2015-12-28 13:46:55,631 DEBUG : BROWSER_OUTPUT: RSS: Main: 225869824 13:46:55 INFO - 2015-12-28 13:46:55,631 DEBUG : BROWSER_OUTPUT: 13:46:55 INFO - 2015-12-28 13:46:55,631 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:46:55 INFO - 2015-12-28 13:46:55,631 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:46:55 INFO - 2015-12-28 13:46:55,631 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:46:55 INFO - 2015-12-28 13:46:55,632 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:46:55 INFO - 2015-12-28 13:46:55,633 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3262.200760813601;3315.4695248760204;3333.483310086936;3344.7658663893535;3360.4623260278354;5558.805441809537;5565.053940830058;5591.916121258185;5617.129344951529;5620.91568626471;5570.944290557093;5575.609707320489;5595.908797784434;5600.6079574429805;5618.325800903887;5037;5108.489151084889;5149.588032957355;5158.742062896859;5231;5069.087564238435;5078.847634570969;5176.275321454999;5179.870503237412;5235.764390602432;5164.819231326905;5181.948180518184;5215.86960325993;5219.347581552306;5243.6853788772605;5154.716490593016;5178.456262092502;5219.973900130494;5248.81629142982;5255.710935898524;5068.4424713281505;5091.592672586185;5115.820946266863;5118.334616499868;5163.793448262065;5466.835994920159;5478.808241711561;5488.890222195574;5493.835184944418;5543.417941116206;5975.731092100866;6198.4731297839735;6203.875922481525;6213.627182369072;6215.7513699451965;6026.156338112668;6077.942788796952;6094.116353128816;6097.146399504073;6117.296510901258;5725.169850371714;5731.799387021434;5735.942640573582;5737.8565535861935;5750.2237197978575;5983.311919129269;6083.239595050619;6177.135201071854;6216.689165541705;6220.098085777537;5885.028970219952;5926.496247818897;5981.551383646244;5995.340512543617;6026.969865150734;6113.38866113394;6127.571070025145;6141.631502109888;6161.969190154021;6168.753249870045;5922.052471604523;6046.818595442144;6057;6120.908186377208;6135.938640613536;6127.997769102053;6131.570790044654;6140;6141.785037523665;6158.137860699506;4686.906261874743;4692.6245900327895;4706.929396059062;4710.199266124767;4723.504032076651;4117.649999750055;4123.299039163349;4196.328587425997;4201.2017716633745;4224.302990006615;5837.708114594253;5854.677992710442;5858.238429004287;5867.149263356875;5871.853203669943;6178.227721534809;6192.349803270682;6197.03945888388;6201.844953876099;6205.100260462298;5633.521150702154;5648.491635752802;5705.657660540381;5711.971440142773;5732.3407808101765;5264.6051546134195;5319.760610772524;5327.067763141435;5333.386660534011;5348.064088784447;6117.785877494266;6355.523335749837;6374.394432528902;6379.64911929839;6387.137736405619;6051.636901785819;6077.787277445268;6143.771245750957;6158.846028849314;6162.22972128484;6302;6322.46259067966;6331.366863313632;6334.809955701337;6346.01636746305;5798.56510761703;5905.793297234576;6060.90908636362;6062.5453091019235;6074.787382441594;6126.356732543019;6219.595726277958;6230.937690623035;6236.438720515175;6243.875122497616;5972.761089556369;5983.790567330297;5987.64074155552;5997.190379298739;6028.457438830526;5747.856303592276;5852.356240813422;5978.880422391615;5986.850328741816;5998.940010600013;5724.513416359656;5803.071508558611;5806.071028635398;5806.912896306474;5832.737526811388;5953.196318497121;5973.104034394875;5993.520518358608;5999.4600485954725;6004.819855404345;5618.971905140448;5710.942890571041;5719.084946408555;5910.911336329872;5922.1412895130825 13:46:55 INFO - 2015-12-28 13:46:55,634 DEBUG : BROWSER_OUTPUT: |1;ext.html;603.6679826095647;626.5833220908094;631.7378288010476;635.7361694896618;649.886269902767;42559.36160957584;42977.140457190835;43117.35323970143;43164;43179.56820431795;46323.53676463234;47007.29489057667;47010.76494617522;47020.29469557959;47164;8324.66701331946;8405.537695426749;9144.542772861363;9312.255019598417;10486.370817750922;10643.095336896373;10722.410267435327;10761.30051546647;10770.084542813871;10782.514786834572;10785.191110666692;10918;10918.836217456745;10925.726856828604;10929.125669946385;10630.096441802418;10714.142868570574;10723.946380268088;10728.249022568423;10733.355998640067;10672.413017284047;10787.244892857503;10793.5682572697;10795.08241799448;10804.0816530595;42920.57079429197;43290.567094328966;43393.13213735739;43474.56525434737;43485.13029739419;3462.3075384922863;3594.245208506217;3597.1007248187952;4126.360414135814;4147.8963025924595;32610.673893261002;32872.3425531488;33180.50229246539;33265.334693305995;33472.3305533888;3784.3377408953324;3850.4801851750217;3859.4982652255308;3878.7672739635714;3924.7645141291614;316926;318165;319721;320094;320249.9999999977;65429;66894.66552667302;69133.65433172902;69594.65202673954;69595;73511.26488735044;74226;74682.25317746753;74859.62570187222;75047.24952750403;16424.260908259155;16488.505344839676;16581.83418165803;16607.08661023631;16629.584260393585;13854;13925.582232533041;13927.025108242326;13932.373043212878;13952.16287022782;22152.335429937128;22659.187265018758;22659.773402266095;22692.20577279787;22785.430364241027;8413.70552030676;8676.262517686067;8722.215000649972;8740.519271440131;8745.956270218609;1029.917606591471;1069.8823129455754;1109.051760744568;1134.733337665648;1152.8386025956372;30084.097477075724;30441.23896902595;30958.101143421398;31119.68880311213;31296.21759455986;1186.6736647422028;1187.9584214552622;1208.8851559101872;1213.2114125818289;1215.465195314059;14713.92643036778;16170.110643914697;17280.827191728175;17636.38272660451;18017.459476215736;470921;471094;471640;472381;472786;61899.69050154721;62828.37171628317;62890;63498.6825065881;63594.36405635977;1372.8078069070339;1393.5540626999466;1479.977800332996;1509.7659862721296;1559.2593518078822;30928.381432370777;30972.535411968387;30997.39341462691;31459.528107077953;31846.203844904063;48883;49334;49340.50659493359;49387;49460.258096127865;324704;325980;327362;328388;329057;35809.82095089508;36235.45646815353;36297.81851090727;36509.634903651684;36826.63173368232;45744.31383529183;46395.76802115968;46927;47052;47225.763871180425;38956;39729;39799.403008955465;40294;40780.59219407768;43653;46125.76937115293;46622;46720.29919551277;47192.528074718815;40624.519686054926;41236.79381603073;41366.793166033975;41397.79301103475;41468.79265603652;34898.82550587231;34951.65018396418;35755;35958.460623091196;36416.27167456583;27125.457490850466;27733.44533109367;27927.16218513448;28067.578986314813;28142.859285703442 13:46:55 INFO - 2015-12-28 13:46:55,638 DEBUG : BROWSER_OUTPUT: |2;jquery.html;376.3564305038384;377.46400111841183;384.9172427927996;386.4493097336295;391.2819975345241;13946.651333716662;14169.645758856008;19114.90442547787;20825.583488330245;20856.582868342644;13318.40067196976;13680.657983550416;13684.042117051811;19812.70280945787;20130;4733.928991065128;4880.829170979016;4887.413510378742;4898.044881248158;4898.975505122487;4841.346418233528;4875.414950205963;4882.462929077798;4885.291632713254;4890.997345544155;3895.7467764595212;4842.41890973082;4846.0550192712435;4848;4947.9505204947845;5208.8958220835375;5257.921131183035;5260.736963151827;5264.763085661135;5272.024675435037;4483.843065492725;4571.3600095986585;4576.931346029813;4583.404157459542;4588.0365123324145;14951.626209344853;15268.236588170546;15378.769318460232;15525.534233972887;15533.223338833126;1972.8125828046457;2062.412212519425;2181.9127234910584;2211.7788221177916;2239.3505883293824;11047.226694131414;11185.440727963569;11236.438178091063;11289.040431563328;11491.253068550517;1747.0478589168933;1808.6744386010512;1880.8401285890716;1973.930912418073;2017.9495512612154;64323.678381607795;71509;71734;73655.63172184158;73791;7938.483998540077;8024.2376974187355;8025.959870200729;8080.474769139987;8087.838243235103;9705.369151005161;9714.077162669535;9730.95134524323;9735.123838854537;9735.464549449849;6394.104825324458;6466.06242094903;6479;6492.123563318986;6493.740250389931;6731.697073631698;6748.257691653914;6752.898706519406;6772.559783614148;6810.659467026629;3682.931949734547;3706.8887933362043;3707.1288247261873;3730.0488375464083;3734.6452087051684;1273.1215461331838;1277.2272774971195;1287.5043108403331;1309.4369421148997;1323.8676132386684;483.6445212768612;494.7130664214747;529.8595872093898;534.3667753711863;567.1011446856696;12698.80951785724;13045.217286962812;13873.930630346784;13941;14099.647508812363;505.5147058823497;568.0541897740299;572.3418069220346;585.7100735136135;595.1756816808664;7031.718731250795;7285.307895749896;7287.089113860768;7375.483716139819;7439.479236453504;641776;645791;647085;648089;666777;90087;90585;92589;94310;95201.52399237959;631.5547538985005;633.5153607490273;635.8346829824279;636.7643971730489;636.8917284061721;11954.103442241692;12133.817992729939;12280.75438491243;12321.383930803604;12325.445354959227;36850.44724329191;37497.2500549982;37613.2477350446;38594.6140538591;41535;53242.46757532375;54458.18312725391;55059.17411238755;55701;55968.44031559632;7367;7474.289942455458;7582.128055273714;7600.46796724224;7604.657790399335;13206.867931320563;13499.73000539964;13556.59330220095;13585.728285434434;13630.1140425872;11610.535578576762;11797.587084452003;12027.939860300992;12047.819282710941;12093.455794489446;11125.944370278097;11239.719007024889;11375.488103035217;11541.192116551762;11603.36181510025;10399.94800025995;12157.331346776013;12356.25862448256;12513;12658.683532911382;6980.755673551402;7424.294692004251;7568.659410326439;7591.089069311718;7652.80867978305;12075.637730868088;12137.635870923887;12289.201201921847;12303.077269205025;12540.310282934526 13:46:55 INFO - 2015-12-28 13:46:55,639 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1534.647031182828;1539.0457916092025;1724.9396271130513;1818.73628323893;1846.0677357934246;7352.301531354527;7510.737124200654;7867.1739467355965;7976.999999999993;8006.91993080069;7702.8844567331535;7911.406644501657;8032.839343213132;8038.356931445485;8045.115037345888;2255.041607316892;2268.0360846640197;2275.0217406515194;2282.6461898405773;2288.096202000209;2046.2428901306537;2101.674240492726;2189.2994241842616;2247.1236217875044;2342.16853017179;2180.7165068541067;2205.724284464442;2212.3694746997107;2212.8008479236864;2213.1921848525253;2390.1873363056557;2406.5427568761966;2407.2296865003204;2407.4944261705064;2410.614301711735;2294.4263934016494;2361.1853910401055;2362.2795047510504;2363.066588697455;2363.2083252110565;8016.358691304682;8036.35709143273;8060.838783224362;8105.1489593593005;8107.95946020272;4810.06203790261;4927.90144197114;4950.034743225073;4961.950380496185;4964.404271487409;3234.9029529113927;3241.1086951088405;3287.8356082195796;3300;3301.851416686255;1064.5262858028182;1071.710638127709;1098.1544210957597;1100.7963526747578;1141.8173092305192;11092.833607495893;11097.667069987914;11098.500567474483;11099;11104.056155226815;4541.568550987651;4549.613282870993;4592.816287348469;4595.770211489412;4606.539346065367;9426.811463770686;9459.148676619;9462.148406643435;9462.29032822541;9479.76300592477;5041.294218809369;5061.8734531637;5062.974685126551;5071.543561079447;5079.492050794965;4640.489546149921;4646.4191976003;4647.024124933734;4653.976730116396;4654.162250794821;3769.849206031783;3800.6959443244473;3823.5794062653085;3831.1379939513945;3849.9037524062123;1143.274020996673;1170.473287020827;1211.5214490276467;1274.9107562470538;1313.0611612696966;1182.722060315825;1187.091874715843;1239.0149830884468;1482.8887833412537;1503.6090616439803;7691.615419229016;7717.498362606412;7782.494137881133;7784.883226751604;7792.41556883236;1204.602481181208;1215.0583297944163;1218.8842060004463;1220.5911019808286;1223.932683702387;6227.813165605039;6267.122602835607;6308.968455157787;6328.272248691367;6338.080978258219;9575.808483830284;9876.950615246878;9881.851772223423;9882.4564648945;9890.258230632731;9576.616935322509;9746.561404736804;9771.31600787938;9772.413655180711;9776.804463910681;7649.885251721229;7678.808029799188;7683.5774032427635;7699.653515591812;7708.421868359896;7355.485116041826;7395.260473952561;7470.178280389261;7471;7521.247875212435;8694.39139260271;8774.692885748967;8791.604377803142;8816.162464565856;8876.689315873913;8872.689455869013;8993.28053755685;9017.864732028893;9035.728928132166;9118.042605526323;7137.429005679637;7141.607211603412;7184.209736928829;7187.209406965334;7188.784336469915;7019.087518622547;7728.4590078693955;7901.249381308767;7936.841263174589;7969.242921922408;6903.102596662402;7122.287771222836;7511.3615342696485;7595.278448547379;7631.122420921665;7290.526115802668;7377.077865266841;7399;7449.329560339595;7468.775936721907;7452.329290363893;7454.515456495311;7474.476786625101;7518.661660225193;7527.774166775005;6815.93184068153;6817.795466136024;6822.215445223863;6830.5218634697085;6885.1049363582415;6886.345797149263;6919.169699636076;6939;6939.965300173467;6942.583444993316 13:46:55 INFO - 2015-12-28 13:46:55,643 DEBUG : BROWSER_OUTPUT: |4;prototype.html;368.3075817463169;369.3241368296018;370.377765354205;371.2056199732571;377.739359841709;5858.20914176586;5944.405559444053;5967.940320596793;5974.522038236947;5974.910376344353;5804.854878628036;5863.472287494124;5893.174955506232;5901.970490147543;5910.734016969236;4678.672492925497;4680.672352935296;4681.859544213679;4682.836100736458;4684.906301873952;4684.180268453024;4684.531546845323;4688.601468875133;4690.507496712848;4693.624510039189;4586.44962604488;4657.6273898088075;4697.8590642280615;4710.670253082286;4717.787699553528;4699.036697477009;4702.130105930414;4708.505606911259;4719.882002949919;4728;4009.29837278478;4181.937270940938;4187.099773548671;4192.140611174702;4210.45264115666;5529.917051244234;5561.6663000220115;5571.470710282517;5579.0515612346;5593.3847276799515;5377.516023557899;5397.4062853086525;5406;5413.458654134555;5414.675119492804;6272.56092073555;6277.717502712343;6278.4035516625845;6278.623282603058;6301.590396624205;4501.032278060233;4578.198815207359;4581.541845815392;4589.1968905441745;4614.838480653195;6486.513511486657;6518.771842985473;6546.770863019819;6548.476121910236;6554.93445065548;4778.689385189951;4788.904221915543;4793.304970779287;4793.856184314476;4794.856154315376;4779.450363208206;4850.53919877611;4851.272309153655;4861.659683822169;4862.854114376574;5397.595180361489;5399.784008639689;5400.378956419983;5407.513323800877;5408.594355423359;6314.557980941382;6352.523560732963;6352.61884286935;6367.235931688135;6379.234491861006;1734.9392771252947;1760.1551255397226;1761.0490335219095;1761.11944027986;1761.3218910719208;1183.7750827342777;1206.2280140709952;1206.6138835572708;1209.8064309710403;1237.1154624443566;6205.47253483459;6214.782482613087;6216.471599913967;6224.470919971853;6229.937700622936;6515.51133664977;6540.37866402691;6542.738290468423;6549.836254093686;6573.408393244536;6076.817695469143;6177.351378105324;6178.567500274938;6184.072389141665;6186.938130618726;3587.982060089735;3611.223586928823;3617.7105831533413;3621.149029977953;3626.111602657366;6609.768658096944;6614.669266536654;6717.093192419059;6731.461483081342;6741.292164322774;6632.369924857131;6648.634325112165;6674.599524028574;6689.933100669028;6692.564983276072;6671.832429324946;6672.79981600543;6678.131842860397;6686.297938716365;6687.899681504781;6375.203099612549;6576.112224849775;6616.7022483987375;6647.867042659216;6650.102236198051;6533.967330163318;6570.671466426755;6573.934260657332;6590.275069742229;6593.175853018372;6755.256921738703;6780.796576102724;6808.93191068083;6843.589384636938;6843.692033858588;4591.265397536378;4701.130290896195;4701.882452938704;4704.200285951465;4706.505816889177;6599.142111525663;6620.933790662032;6643.30245324234;6646.202455705346;6661.733530658913;6366.9681651591445;6414.839629009312;6417.839554011187;6422.486201103994;6423.389777971085;6228.688565571794;6233.065040244;6271.843203919939;6279.623222606659;6411.775587854403;6231.875362492816;6232.189815323979;6235.906461403173;6239.844003899939;6242.282137554058;6348.555601107878;6358.968205158944;6360.650164241011;6361.840953976188;6365.554411191358;6099.207103076572;6197.721102550306;6205.069239614094;6206;6222.471089957405 13:46:55 INFO - 2015-12-28 13:46:55,643 DEBUG : BROWSER_OUTPUT: |5;yui.html;822.4900561651776;883.5802993578055;889.1330952321488;914.7621618379219;914.9862752058721;13284.136531125481;13356.799648005288;13679.110857794261;13700.725985480285;13724.725505489885;13041.08712390133;13140;13160.341982900865;13169.275689837055;13172.47310107597;735.3528894572781;756.0285033731656;897.2687259883207;917.6833992272656;918.8392031394512;896.596531560797;901.1034021148934;902.0438335364502;906.2206502407923;908.3686837647838;780.2548566119342;795.6260557537948;946.4274114160937;957.5834511987273;957.8419560772464;934.7242563443766;950.4059962523423;952.3238500664537;952.5237381309346;953.0279115302387;703.5848849178958;705.6824429006967;705.9364657180878;705.9752908648172;706.3148745716646;13189;13268.800967985488;13314.201147931059;13328.466861325536;13336.266505342202;11729.472173752201;11733.120015998835;11827.290362578187;11945.940270298679;12055.276683399024;9252.953735231347;9480.336376453652;9587.280953928414;9745;9859.211263098934;3679.797611131387;3681.3005528949416;3691.187938653519;3716.7026637868908;3723.6090210527777;54867.45132548703;55291.72354138244;56712;56842.715786420806;56963.430365696644;9361.719148425422;9562.904370956341;9572.377795443273;9641.710748677551;9751.707448776548;17674.558136046446;17827.376041838474;17838.732419013726;17844.732329015074;17873.910630446764;7510.248975102446;7591.544507329578;7628.580428076509;7766.5728384939375;7818.921810781933;4262.7016108872085;4296.033392486665;4322.913541729148;4334.349847522833;4373.825046998148;3178.268998130443;3214.0197239842073;3216.083416226411;3221.4845624699938;3222.5971753530807;484.36548121960345;496.1045313209691;502.67577412568687;505.29511331692817;509.1802198460476;521.7078436075734;648.9578177418452;706.5689929143322;721.3760097515611;727.7125535413483;8417.410781245377;9000.8649870252;9064.320175986828;9105.2260557852;9399.953000234955;478.26824957814597;597.5996082624652;601.5278006764669;656.1830521001384;657.9046038324416;4217.8523751668545;4228.4080228768;4341.674374421931;4345.30475123985;4386.342048692658;64215.6789216051;69758.30241697619;70219.64890175516;70370;70446;54740;54908.450915491136;55670.72164639151;55862.44137558654;57250.141247881314;54593.727031364586;55001;55367;55458.72270638621;56756.71621641865;8917.910820891968;8938.731838044869;9135.588898499716;9290.860637090314;9293.12754631697;39573.80213098916;40382.79808600938;40704.79647601743;40965.1806963865;41032;50789;54283;55042.72478637581;55350.44649553453;55769.1634625489;8112.351011919151;8293.751187464386;8593.95703021481;8674.956625216833;8700.477971321741;12125.151239413157;12245.938770306091;12345.444454999368;12431;12953.805692914426;11479.598214062467;11510.712232193928;11556.826647600124;11564;11938.462769175234;11005.669829905115;11355.602553910574;11364.886351136383;11522;11830.763384732429;11354.148438867283;11356.659300221007;11380.487878045342;11392.658220253406;11474.770504589695;9988.151007164472;10096.949515252376;10182.236332275257;10268.229882758673;10378;9172.587233574372;9229.49237791928;9323.953380233055;9443.338966272295;9640.903590964 13:46:55 INFO - 2015-12-28 13:46:55,643 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:46:55 INFO - 2015-12-28 13:46:55,643 DEBUG : BROWSER_OUTPUT: __start_cc_report 13:46:55 INFO - 2015-12-28 13:46:55,643 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,791 13:46:55 INFO - 2015-12-28 13:46:55,643 DEBUG : BROWSER_OUTPUT: __end_cc_report 13:46:55 INFO - 2015-12-28 13:46:55,643 DEBUG : BROWSER_OUTPUT: __startTimestamp1451339215630__endTimestamp 13:46:55 INFO - 2015-12-28 13:46:55,644 DEBUG : BROWSER_OUTPUT: 13:46:55 INFO - 2015-12-28 13:46:55,644 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:46:55 INFO - 2015-12-28 13:46:55,644 DEBUG : BROWSER_OUTPUT: Number of tests: 6 13:46:55 INFO - 2015-12-28 13:46:55,645 DEBUG : BROWSER_OUTPUT: 13:46:55 INFO - 2015-12-28 13:46:55,645 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5654.26 Median:5854.68 stddev:643.87 (11.0%) stddev-sans-first:617.89 13:46:55 INFO - 2015-12-28 13:46:55,645 DEBUG : BROWSER_OUTPUT: Values: 3262.2 3315.5 3333.5 3344.8 3360.5 5558.8 5565.1 5591.9 5617.1 5620.9 5570.9 5575.6 5595.9 5600.6 5618.3 5037.0 5108.5 5149.6 5158.7 5231.0 5069.1 5078.8 5176.3 5179.9 5235.8 5164.8 5181.9 5215.9 5219.3 5243.7 5154.7 5178.5 5220.0 5248.8 5255.7 5068.4 5091.6 5115.8 5118.3 5163.8 5466.8 5478.8 5488.9 5493.8 5543.4 5975.7 6198.5 6203.9 6213.6 6215.8 6026.2 6077.9 6094.1 6097.1 6117.3 5725.2 5731.8 5735.9 5737.9 5750.2 5983.3 6083.2 6177.1 6216.7 6220.1 5885.0 5926.5 5981.6 5995.3 6027.0 6113.4 6127.6 6141.6 6162.0 6168.8 5922.1 6046.8 6057.0 6120.9 6135.9 6128.0 6131.6 6140.0 6141.8 6158.1 4686.9 4692.6 4706.9 4710.2 4723.5 4117.6 4123.3 4196.3 4201.2 4224.3 5837.7 5854.7 5858.2 5867.1 5871.9 6178.2 6192.3 6197.0 6201.8 6205.1 5633.5 5648.5 5705.7 5712.0 5732.3 5264.6 5319.8 5327.1 5333.4 5348.1 6117.8 6355.5 6374.4 6379.6 6387.1 6051.6 6077.8 6143.8 6158.8 6162.2 6302.0 6322.5 6331.4 6334.8 6346.0 5798.6 5905.8 6060.9 6062.5 6074.8 6126.4 6219.6 6230.9 6236.4 6243.9 5972.8 5983.8 5987.6 5997.2 6028.5 5747.9 5852.4 5978.9 5986.9 5998.9 5724.5 5803.1 5806.1 5806.9 5832.7 5953.2 5973.1 5993.5 5999.5 6004.8 5619.0 5710.9 5719.1 5910.9 5922.1 13:46:55 INFO - 2015-12-28 13:46:55,645 DEBUG : BROWSER_OUTPUT: 13:46:55 INFO - 2015-12-28 13:46:55,645 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:56038.42 Median:19702.03 stddev:99816.41 (506.6%) stddev-sans-first:100009.64 13:46:55 INFO - 2015-12-28 13:46:55,645 DEBUG : BROWSER_OUTPUT: Values: 603.7 626.6 631.7 635.7 649.9 42559.4 42977.1 43117.4 43164.0 43179.6 46323.5 47007.3 47010.8 47020.3 47164.0 8324.7 8405.5 9144.5 9312.3 10486.4 10643.1 10722.4 10761.3 10770.1 10782.5 10785.2 10918.0 10918.8 10925.7 10929.1 10630.1 10714.1 10723.9 10728.2 10733.4 10672.4 10787.2 10793.6 10795.1 10804.1 42920.6 43290.6 43393.1 43474.6 43485.1 3462.3 3594.2 3597.1 4126.4 4147.9 32610.7 32872.3 33180.5 33265.3 33472.3 3784.3 3850.5 3859.5 3878.8 3924.8 316926.0 318165.0 319721.0 320094.0 320250.0 65429.0 66894.7 69133.7 69594.7 69595.0 73511.3 74226.0 74682.3 74859.6 75047.2 16424.3 16488.5 16581.8 16607.1 16629.6 13854.0 13925.6 13927.0 13932.4 13952.2 22152.3 22659.2 22659.8 22692.2 22785.4 8413.7 8676.3 8722.2 8740.5 8746.0 1029.9 1069.9 1109.1 1134.7 1152.8 30084.1 30441.2 30958.1 31119.7 31296.2 1186.7 1188.0 1208.9 1213.2 1215.5 14713.9 16170.1 17280.8 17636.4 18017.5 470921.0 471094.0 471640.0 472381.0 472786.0 61899.7 62828.4 62890.0 63498.7 63594.4 1372.8 1393.6 1480.0 1509.8 1559.3 30928.4 30972.5 30997.4 31459.5 31846.2 48883.0 49334.0 49340.5 49387.0 49460.3 324704.0 325980.0 327362.0 328388.0 329057.0 35809.8 36235.5 36297.8 36509.6 36826.6 45744.3 46395.8 46927.0 47052.0 47225.8 38956.0 39729.0 39799.4 40294.0 40780.6 43653.0 46125.8 46622.0 46720.3 47192.5 40624.5 41236.8 41366.8 41397.8 41468.8 34898.8 34951.7 35755.0 35958.5 36416.3 27125.5 27733.4 27927.2 28067.6 28142.9 13:46:55 INFO - 2015-12-28 13:46:55,646 DEBUG : BROWSER_OUTPUT: 13:46:55 INFO - 2015-12-28 13:46:55,646 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:31740.45 Median:4660.98 stddev:106609.94 (2287.3%) stddev-sans-first:106883.00 13:46:55 INFO - 2015-12-28 13:46:55,647 DEBUG : BROWSER_OUTPUT: Values: 376.4 377.5 384.9 386.4 391.3 13946.7 14169.6 19114.9 20825.6 20856.6 13318.4 13680.7 13684.0 19812.7 20130.0 4733.9 4880.8 4887.4 4898.0 4899.0 4841.3 4875.4 4882.5 4885.3 4891.0 3895.7 4842.4 4846.1 4848.0 4948.0 5208.9 5257.9 5260.7 5264.8 5272.0 4483.8 4571.4 4576.9 4583.4 4588.0 14951.6 15268.2 15378.8 15525.5 15533.2 1972.8 2062.4 2181.9 2211.8 2239.4 11047.2 11185.4 11236.4 11289.0 11491.3 1747.0 1808.7 1880.8 1973.9 2017.9 64323.7 71509.0 71734.0 73655.6 73791.0 7938.5 8024.2 8026.0 8080.5 8087.8 9705.4 9714.1 9731.0 9735.1 9735.5 6394.1 6466.1 6479.0 6492.1 6493.7 6731.7 6748.3 6752.9 6772.6 6810.7 3682.9 3706.9 3707.1 3730.0 3734.6 1273.1 1277.2 1287.5 1309.4 1323.9 483.6 494.7 529.9 534.4 567.1 12698.8 13045.2 13873.9 13941.0 14099.6 505.5 568.1 572.3 585.7 595.2 7031.7 7285.3 7287.1 7375.5 7439.5 641776.0 645791.0 647085.0 648089.0 666777.0 90087.0 90585.0 92589.0 94310.0 95201.5 631.6 633.5 635.8 636.8 636.9 11954.1 12133.8 12280.8 12321.4 12325.4 36850.4 37497.3 37613.2 38594.6 41535.0 53242.5 54458.2 55059.2 55701.0 55968.4 7367.0 7474.3 7582.1 7600.5 7604.7 13206.9 13499.7 13556.6 13585.7 13630.1 11610.5 11797.6 12027.9 12047.8 12093.5 11125.9 11239.7 11375.5 11541.2 11603.4 10399.9 12157.3 12356.3 12513.0 12658.7 6980.8 7424.3 7568.7 7591.1 7652.8 12075.6 12137.6 12289.2 12303.1 12540.3 13:46:55 INFO - 2015-12-28 13:46:55,647 DEBUG : BROWSER_OUTPUT: 13:46:55 INFO - 2015-12-28 13:46:55,647 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5721.42 Median:6816.86 stddev:2939.44 (43.1%) stddev-sans-first:2930.84 13:46:55 INFO - 2015-12-28 13:46:55,647 DEBUG : BROWSER_OUTPUT: Values: 1534.6 1539.0 1724.9 1818.7 1846.1 7352.3 7510.7 7867.2 7977.0 8006.9 7702.9 7911.4 8032.8 8038.4 8045.1 2255.0 2268.0 2275.0 2282.6 2288.1 2046.2 2101.7 2189.3 2247.1 2342.2 2180.7 2205.7 2212.4 2212.8 2213.2 2390.2 2406.5 2407.2 2407.5 2410.6 2294.4 2361.2 2362.3 2363.1 2363.2 8016.4 8036.4 8060.8 8105.1 8108.0 4810.1 4927.9 4950.0 4962.0 4964.4 3234.9 3241.1 3287.8 3300.0 3301.9 1064.5 1071.7 1098.2 1100.8 1141.8 11092.8 11097.7 11098.5 11099.0 11104.1 4541.6 4549.6 4592.8 4595.8 4606.5 9426.8 9459.1 9462.1 9462.3 9479.8 5041.3 5061.9 5063.0 5071.5 5079.5 4640.5 4646.4 4647.0 4654.0 4654.2 3769.8 3800.7 3823.6 3831.1 3849.9 1143.3 1170.5 1211.5 1274.9 1313.1 1182.7 1187.1 1239.0 1482.9 1503.6 7691.6 7717.5 7782.5 7784.9 7792.4 1204.6 1215.1 1218.9 1220.6 1223.9 6227.8 6267.1 6309.0 6328.3 6338.1 9575.8 9877.0 9881.9 9882.5 9890.3 9576.6 9746.6 9771.3 9772.4 9776.8 7649.9 7678.8 7683.6 7699.7 7708.4 7355.5 7395.3 7470.2 7471.0 7521.2 8694.4 8774.7 8791.6 8816.2 8876.7 8872.7 8993.3 9017.9 9035.7 9118.0 7137.4 7141.6 7184.2 7187.2 7188.8 7019.1 7728.5 7901.2 7936.8 7969.2 6903.1 7122.3 7511.4 7595.3 7631.1 7290.5 7377.1 7399.0 7449.3 7468.8 7452.3 7454.5 7474.5 7518.7 7527.8 6815.9 6817.8 6822.2 6830.5 6885.1 6886.3 6919.2 6939.0 6940.0 6942.6 13:46:55 INFO - 2015-12-28 13:46:55,647 DEBUG : BROWSER_OUTPUT: 13:46:55 INFO - 2015-12-28 13:46:55,648 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5364.37 Median:6088.01 stddev:1550.24 (25.5%) stddev-sans-first:1508.56 13:46:55 INFO - 2015-12-28 13:46:55,649 DEBUG : BROWSER_OUTPUT: Values: 368.3 369.3 370.4 371.2 377.7 5858.2 5944.4 5967.9 5974.5 5974.9 5804.9 5863.5 5893.2 5902.0 5910.7 4678.7 4680.7 4681.9 4682.8 4684.9 4684.2 4684.5 4688.6 4690.5 4693.6 4586.4 4657.6 4697.9 4710.7 4717.8 4699.0 4702.1 4708.5 4719.9 4728.0 4009.3 4181.9 4187.1 4192.1 4210.5 5529.9 5561.7 5571.5 5579.1 5593.4 5377.5 5397.4 5406.0 5413.5 5414.7 6272.6 6277.7 6278.4 6278.6 6301.6 4501.0 4578.2 4581.5 4589.2 4614.8 6486.5 6518.8 6546.8 6548.5 6554.9 4778.7 4788.9 4793.3 4793.9 4794.9 4779.5 4850.5 4851.3 4861.7 4862.9 5397.6 5399.8 5400.4 5407.5 5408.6 6314.6 6352.5 6352.6 6367.2 6379.2 1734.9 1760.2 1761.0 1761.1 1761.3 1183.8 1206.2 1206.6 1209.8 1237.1 6205.5 6214.8 6216.5 6224.5 6229.9 6515.5 6540.4 6542.7 6549.8 6573.4 6076.8 6177.4 6178.6 6184.1 6186.9 3588.0 3611.2 3617.7 3621.1 3626.1 6609.8 6614.7 6717.1 6731.5 6741.3 6632.4 6648.6 6674.6 6689.9 6692.6 6671.8 6672.8 6678.1 6686.3 6687.9 6375.2 6576.1 6616.7 6647.9 6650.1 6534.0 6570.7 6573.9 6590.3 6593.2 6755.3 6780.8 6808.9 6843.6 6843.7 4591.3 4701.1 4701.9 4704.2 4706.5 6599.1 6620.9 6643.3 6646.2 6661.7 6367.0 6414.8 6417.8 6422.5 6423.4 6228.7 6233.1 6271.8 6279.6 6411.8 6231.9 6232.2 6235.9 6239.8 6242.3 6348.6 6359.0 6360.7 6361.8 6365.6 6099.2 6197.7 6205.1 6206.0 6222.5 13:46:55 INFO - 2015-12-28 13:46:55,649 DEBUG : BROWSER_OUTPUT: 13:46:55 INFO - 2015-12-28 13:46:55,649 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:15081.83 Median:55358.72 stddev:18887.62 (34.1%) stddev-sans-first:18910.25 13:46:55 INFO - 2015-12-28 13:46:55,649 DEBUG : BROWSER_OUTPUT: Values: 822.5 883.6 889.1 914.8 915.0 13284.1 13356.8 13679.1 13700.7 13724.7 13041.1 13140.0 13160.3 13169.3 13172.5 735.4 756.0 897.3 917.7 918.8 896.6 901.1 902.0 906.2 908.4 780.3 795.6 946.4 957.6 957.8 934.7 950.4 952.3 952.5 953.0 703.6 705.7 705.9 706.0 706.3 13189.0 13268.8 13314.2 13328.5 13336.3 11729.5 11733.1 11827.3 11945.9 12055.3 9253.0 9480.3 9587.3 9745.0 9859.2 3679.8 3681.3 3691.2 3716.7 3723.6 54867.5 55291.7 56712.0 56842.7 56963.4 9361.7 9562.9 9572.4 9641.7 9751.7 17674.6 17827.4 17838.7 17844.7 17873.9 7510.2 7591.5 7628.6 7766.6 7818.9 4262.7 4296.0 4322.9 4334.3 4373.8 3178.3 3214.0 3216.1 3221.5 3222.6 484.4 496.1 502.7 505.3 509.2 521.7 649.0 706.6 721.4 727.7 8417.4 9000.9 9064.3 9105.2 9400.0 478.3 597.6 601.5 656.2 657.9 4217.9 4228.4 4341.7 4345.3 4386.3 64215.7 69758.3 70219.6 70370.0 70446.0 54740.0 54908.5 55670.7 55862.4 57250.1 54593.7 55001.0 55367.0 55458.7 56756.7 8917.9 8938.7 9135.6 9290.9 9293.1 39573.8 40382.8 40704.8 40965.2 41032.0 50789.0 54283.0 55042.7 55350.4 55769.2 8112.4 8293.8 8594.0 8675.0 8700.5 12125.2 12245.9 12345.4 12431.0 12953.8 11479.6 11510.7 11556.8 11564.0 11938.5 11005.7 11355.6 11364.9 11522.0 11830.8 11354.1 11356.7 11380.5 11392.7 11474.8 9988.2 10096.9 10182.2 10268.2 10378.0 9172.6 9229.5 9324.0 9443.3 9640.9 13:46:55 INFO - 2015-12-28 13:46:55,649 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:46:55 INFO - 2015-12-28 13:46:55,649 DEBUG : BROWSER_OUTPUT: 13:46:56 INFO - 2015-12-28 13:46:56,209 INFO : Browser exited with error code: 0 13:46:56 INFO - 2015-12-28 13:46:56,225 INFO : Completed test dromaeo_css (00:18:30) 13:46:56 INFO - 2015-12-28 13:46:56,226 INFO : Starting test kraken 13:46:56 INFO - 2015-12-28 13:46:56,226 DEBUG : operating with platform_type : linux_ 13:46:56 INFO - 2015-12-28 13:46:56,226 INFO : Initialising browser for kraken test... 13:46:56 INFO - 2015-12-28 13:46:56,232 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpFE4WEu/profile http://localhost:57427/getInfo.html 13:47:00 INFO - 2015-12-28 13:47:00,034 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:47:00 INFO - 2015-12-28 13:47:00,035 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:47:00 INFO - 2015-12-28 13:47:00,035 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 13:47:00 INFO - 2015-12-28 13:47:00,035 DEBUG : BROWSER_OUTPUT: __metrics 13:47:00 INFO - 2015-12-28 13:47:00,139 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:47:01 INFO - 2015-12-28 13:47:01,573 INFO : Browser initialized. 13:47:01 INFO - 2015-12-28 13:47:01,574 INFO : Running cycle 1/1 for kraken test... 13:47:01 INFO - 2015-12-28 13:47:01,574 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpFE4WEu/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:47:13 INFO - 2015-12-28 13:47:13,169 DEBUG : BROWSER_OUTPUT: RSS: Main: 129220608 13:47:13 INFO - 2015-12-28 13:47:13,170 DEBUG : BROWSER_OUTPUT: 13:47:15 INFO - 2015-12-28 13:47:15,658 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57427/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57427/tests/kraken/driver.html?testName=audio-beat-detection) 13:47:16 INFO - 2015-12-28 13:47:16,231 DEBUG : BROWSER_OUTPUT: RSS: Main: 165429248 13:47:16 INFO - 2015-12-28 13:47:16,232 DEBUG : BROWSER_OUTPUT: 13:47:18 INFO - 2015-12-28 13:47:18,781 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57427/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57427/tests/kraken/driver.html?testName=audio-dft) 13:47:19 INFO - 2015-12-28 13:47:19,343 DEBUG : BROWSER_OUTPUT: RSS: Main: 162459648 13:47:19 INFO - 2015-12-28 13:47:19,343 DEBUG : BROWSER_OUTPUT: 13:47:22 INFO - 2015-12-28 13:47:22,145 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57427/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57427/tests/kraken/driver.html?testName=audio-fft) 13:47:22 INFO - 2015-12-28 13:47:22,707 DEBUG : BROWSER_OUTPUT: RSS: Main: 158691328 13:47:22 INFO - 2015-12-28 13:47:22,707 DEBUG : BROWSER_OUTPUT: 13:47:24 INFO - 2015-12-28 13:47:24,653 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57427/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57427/tests/kraken/driver.html?testName=audio-oscillator) 13:47:25 INFO - 2015-12-28 13:47:25,214 DEBUG : BROWSER_OUTPUT: RSS: Main: 157970432 13:47:25 INFO - 2015-12-28 13:47:25,214 DEBUG : BROWSER_OUTPUT: 13:47:27 INFO - 2015-12-28 13:47:27,348 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57427/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57427/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:47:27 INFO - 2015-12-28 13:47:27,902 DEBUG : BROWSER_OUTPUT: RSS: Main: 157450240 13:47:27 INFO - 2015-12-28 13:47:27,903 DEBUG : BROWSER_OUTPUT: 13:47:30 INFO - 2015-12-28 13:47:30,784 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57427/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57427/tests/kraken/driver.html?testName=imaging-darkroom) 13:47:31 INFO - 2015-12-28 13:47:31,358 DEBUG : BROWSER_OUTPUT: RSS: Main: 155717632 13:47:31 INFO - 2015-12-28 13:47:31,358 DEBUG : BROWSER_OUTPUT: 13:47:34 INFO - 2015-12-28 13:47:34,729 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57427/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57427/tests/kraken/driver.html?testName=imaging-desaturate) 13:47:35 INFO - 2015-12-28 13:47:35,297 DEBUG : BROWSER_OUTPUT: RSS: Main: 156823552 13:47:35 INFO - 2015-12-28 13:47:35,297 DEBUG : BROWSER_OUTPUT: 13:47:38 INFO - 2015-12-28 13:47:38,040 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57427/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57427/tests/kraken/driver.html?testName=json-parse-financial) 13:47:38 INFO - 2015-12-28 13:47:38,606 DEBUG : BROWSER_OUTPUT: RSS: Main: 157818880 13:47:38 INFO - 2015-12-28 13:47:38,607 DEBUG : BROWSER_OUTPUT: 13:47:40 INFO - 2015-12-28 13:47:40,114 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57427/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57427/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:47:40 INFO - 2015-12-28 13:47:40,676 DEBUG : BROWSER_OUTPUT: RSS: Main: 163012608 13:47:40 INFO - 2015-12-28 13:47:40,676 DEBUG : BROWSER_OUTPUT: 13:47:42 INFO - 2015-12-28 13:47:42,398 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57427/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57427/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:47:43 INFO - 2015-12-28 13:47:42,999 DEBUG : BROWSER_OUTPUT: RSS: Main: 160940032 13:47:43 INFO - 2015-12-28 13:47:43,000 DEBUG : BROWSER_OUTPUT: 13:47:44 INFO - 2015-12-28 13:47:44,972 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57427/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57427/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:47:45 INFO - 2015-12-28 13:47:45,540 DEBUG : BROWSER_OUTPUT: RSS: Main: 166658048 13:47:45 INFO - 2015-12-28 13:47:45,540 DEBUG : BROWSER_OUTPUT: 13:47:47 INFO - 2015-12-28 13:47:47,839 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57427/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57427/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:47:48 INFO - 2015-12-28 13:47:48,421 DEBUG : BROWSER_OUTPUT: RSS: Main: 169668608 13:47:48 INFO - 2015-12-28 13:47:48,422 DEBUG : BROWSER_OUTPUT: 13:47:50 INFO - 2015-12-28 13:47:50,866 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57427/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57427/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:47:51 INFO - 2015-12-28 13:47:51,434 DEBUG : BROWSER_OUTPUT: RSS: Main: 168972288 13:47:51 INFO - 2015-12-28 13:47:51,434 DEBUG : BROWSER_OUTPUT: 13:47:53 INFO - 2015-12-28 13:47:53,044 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57427/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57427/tests/kraken/driver.html?testName=ai-astar) 13:47:53 INFO - 2015-12-28 13:47:53,289 DEBUG : BROWSER_OUTPUT: RSS: Main: 227856384 13:47:53 INFO - 2015-12-28 13:47:53,289 DEBUG : BROWSER_OUTPUT: 13:47:53 INFO - 2015-12-28 13:47:53,292 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:47:53 INFO - 2015-12-28 13:47:53,293 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:47:53 INFO - 2015-12-28 13:47:53,293 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:47:53 INFO - 2015-12-28 13:47:53,293 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:47:53 INFO - 2015-12-28 13:47:53,293 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;111;103;110;109;110;100;111;111;108 13:47:53 INFO - 2015-12-28 13:47:53,294 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;152;122;145;160;132;147;152;122;160;125 13:47:53 INFO - 2015-12-28 13:47:53,294 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;161;161;162;161;161;161;164;164;162 13:47:53 INFO - 2015-12-28 13:47:53,294 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;73;72;148;71;72;72;73;154;73 13:47:53 INFO - 2015-12-28 13:47:53,294 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;89;91;144;91;90;90;126;89;91;135 13:47:53 INFO - 2015-12-28 13:47:53,294 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;110;112;110;110;109;110;110;109 13:47:53 INFO - 2015-12-28 13:47:53,295 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;146;146;146;146;146;146;146;146;146 13:47:53 INFO - 2015-12-28 13:47:53,295 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;95;96;96;96;96;95;96;96 13:47:53 INFO - 2015-12-28 13:47:53,295 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;54;56;56;55;56;56;58;56;53;56 13:47:53 INFO - 2015-12-28 13:47:53,295 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;63;64;64;63;64;63;63;64;64;63 13:47:53 INFO - 2015-12-28 13:47:53,296 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;79;77;79;79;88;86;80;79;80;79 13:47:53 INFO - 2015-12-28 13:47:53,296 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;114;108;108;108;116;116;111;110;108;119 13:47:53 INFO - 2015-12-28 13:47:53,296 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;136;137;134;134;134;138;134;138;135;140 13:47:53 INFO - 2015-12-28 13:47:53,296 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;63;65;62;63;61;63;62;61;63;63 13:47:53 INFO - 2015-12-28 13:47:53,296 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:47:53 INFO - 2015-12-28 13:47:53,297 DEBUG : BROWSER_OUTPUT: __start_cc_report 13:47:53 INFO - 2015-12-28 13:47:53,297 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,890 13:47:53 INFO - 2015-12-28 13:47:53,297 DEBUG : BROWSER_OUTPUT: __end_cc_report 13:47:53 INFO - 2015-12-28 13:47:53,297 DEBUG : BROWSER_OUTPUT: __startTimestamp1451339273290__endTimestamp 13:47:53 INFO - 2015-12-28 13:47:53,298 DEBUG : BROWSER_OUTPUT: 13:47:53 INFO - 2015-12-28 13:47:53,301 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:47:53 INFO - 2015-12-28 13:47:53,301 DEBUG : BROWSER_OUTPUT: Number of tests: 14 13:47:53 INFO - 2015-12-28 13:47:53,301 DEBUG : BROWSER_OUTPUT: 13:47:53 INFO - 2015-12-28 13:47:53,301 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.10 Median:110.00 stddev:3.73 (3.4%) stddev-sans-first:3.95 13:47:53 INFO - 2015-12-28 13:47:53,302 DEBUG : BROWSER_OUTPUT: Values: 108.0 111.0 103.0 110.0 109.0 110.0 100.0 111.0 111.0 108.0 13:47:53 INFO - 2015-12-28 13:47:53,302 DEBUG : BROWSER_OUTPUT: 13:47:53 INFO - 2015-12-28 13:47:53,302 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:141.70 Median:149.50 stddev:15.17 (10.1%) stddev-sans-first:15.62 13:47:53 INFO - 2015-12-28 13:47:53,302 DEBUG : BROWSER_OUTPUT: Values: 152.0 122.0 145.0 160.0 132.0 147.0 152.0 122.0 160.0 125.0 13:47:53 INFO - 2015-12-28 13:47:53,302 DEBUG : BROWSER_OUTPUT: 13:47:53 INFO - 2015-12-28 13:47:53,302 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:1.25 (0.8%) stddev-sans-first:1.27 13:47:53 INFO - 2015-12-28 13:47:53,302 DEBUG : BROWSER_OUTPUT: Values: 163.0 161.0 161.0 162.0 161.0 161.0 161.0 164.0 164.0 162.0 13:47:53 INFO - 2015-12-28 13:47:53,302 DEBUG : BROWSER_OUTPUT: 13:47:53 INFO - 2015-12-28 13:47:53,302 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:87.90 Median:72.00 stddev:33.29 (46.2%) stddev-sans-first:34.75 13:47:53 INFO - 2015-12-28 13:47:53,303 DEBUG : BROWSER_OUTPUT: Values: 71.0 73.0 72.0 148.0 71.0 72.0 72.0 73.0 154.0 73.0 13:47:53 INFO - 2015-12-28 13:47:53,303 DEBUG : BROWSER_OUTPUT: 13:47:53 INFO - 2015-12-28 13:47:53,303 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:103.60 Median:90.00 stddev:22.09 (24.5%) stddev-sans-first:22.79 13:47:53 INFO - 2015-12-28 13:47:53,303 DEBUG : BROWSER_OUTPUT: Values: 89.0 91.0 144.0 91.0 90.0 90.0 126.0 89.0 91.0 135.0 13:47:53 INFO - 2015-12-28 13:47:53,303 DEBUG : BROWSER_OUTPUT: 13:47:53 INFO - 2015-12-28 13:47:53,303 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.88 (0.8%) stddev-sans-first:0.87 13:47:53 INFO - 2015-12-28 13:47:53,303 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 110.0 112.0 110.0 110.0 109.0 110.0 110.0 109.0 13:47:53 INFO - 2015-12-28 13:47:53,303 DEBUG : BROWSER_OUTPUT: 13:47:53 INFO - 2015-12-28 13:47:53,303 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 13:47:53 INFO - 2015-12-28 13:47:53,303 DEBUG : BROWSER_OUTPUT: Values: 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 13:47:53 INFO - 2015-12-28 13:47:53,304 DEBUG : BROWSER_OUTPUT: 13:47:53 INFO - 2015-12-28 13:47:53,304 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 13:47:53 INFO - 2015-12-28 13:47:53,304 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 95.0 96.0 96.0 96.0 96.0 95.0 96.0 96.0 13:47:53 INFO - 2015-12-28 13:47:53,304 DEBUG : BROWSER_OUTPUT: 13:47:53 INFO - 2015-12-28 13:47:53,304 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:55.60 Median:56.00 stddev:1.35 (2.4%) stddev-sans-first:1.30 13:47:53 INFO - 2015-12-28 13:47:53,304 DEBUG : BROWSER_OUTPUT: Values: 54.0 56.0 56.0 55.0 56.0 56.0 58.0 56.0 53.0 56.0 13:47:53 INFO - 2015-12-28 13:47:53,304 DEBUG : BROWSER_OUTPUT: 13:47:53 INFO - 2015-12-28 13:47:53,304 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:63.50 Median:64.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 13:47:53 INFO - 2015-12-28 13:47:53,305 DEBUG : BROWSER_OUTPUT: Values: 63.0 64.0 64.0 63.0 64.0 63.0 63.0 64.0 64.0 63.0 13:47:53 INFO - 2015-12-28 13:47:53,305 DEBUG : BROWSER_OUTPUT: 13:47:53 INFO - 2015-12-28 13:47:53,305 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:80.60 Median:79.50 stddev:3.50 (4.4%) stddev-sans-first:3.67 13:47:53 INFO - 2015-12-28 13:47:53,305 DEBUG : BROWSER_OUTPUT: Values: 79.0 77.0 79.0 79.0 88.0 86.0 80.0 79.0 80.0 79.0 13:47:53 INFO - 2015-12-28 13:47:53,305 DEBUG : BROWSER_OUTPUT: 13:47:53 INFO - 2015-12-28 13:47:53,305 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:111.80 Median:112.50 stddev:4.13 (3.7%) stddev-sans-first:4.30 13:47:53 INFO - 2015-12-28 13:47:53,305 DEBUG : BROWSER_OUTPUT: Values: 114.0 108.0 108.0 108.0 116.0 116.0 111.0 110.0 108.0 119.0 13:47:53 INFO - 2015-12-28 13:47:53,305 DEBUG : BROWSER_OUTPUT: 13:47:53 INFO - 2015-12-28 13:47:53,305 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:136.00 Median:136.50 stddev:2.16 (1.6%) stddev-sans-first:2.29 13:47:53 INFO - 2015-12-28 13:47:53,306 DEBUG : BROWSER_OUTPUT: Values: 136.0 137.0 134.0 134.0 134.0 138.0 134.0 138.0 135.0 140.0 13:47:53 INFO - 2015-12-28 13:47:53,306 DEBUG : BROWSER_OUTPUT: 13:47:53 INFO - 2015-12-28 13:47:53,306 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.60 Median:63.00 stddev:1.17 (1.9%) stddev-sans-first:1.24 13:47:53 INFO - 2015-12-28 13:47:53,306 DEBUG : BROWSER_OUTPUT: Values: 63.0 65.0 62.0 63.0 61.0 63.0 62.0 61.0 63.0 63.0 13:47:53 INFO - 2015-12-28 13:47:53,306 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:47:53 INFO - 2015-12-28 13:47:53,306 DEBUG : BROWSER_OUTPUT: 13:47:53 INFO - 2015-12-28 13:47:53,985 INFO : Browser exited with error code: 0 13:47:54 INFO - 2015-12-28 13:47:54,039 INFO : Completed test kraken (00:00:57) 13:47:54 INFO - 2015-12-28 13:47:54,039 INFO : Starting test v8_7 13:47:54 INFO - 2015-12-28 13:47:54,039 DEBUG : operating with platform_type : linux_ 13:47:54 INFO - 2015-12-28 13:47:54,039 INFO : Initialising browser for v8_7 test... 13:47:54 INFO - 2015-12-28 13:47:54,045 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpuC5mdt/profile http://localhost:57427/getInfo.html 13:47:57 INFO - 2015-12-28 13:47:57,941 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:47:57 INFO - 2015-12-28 13:47:57,941 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:47:57 INFO - 2015-12-28 13:47:57,941 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 13:47:57 INFO - 2015-12-28 13:47:57,941 DEBUG : BROWSER_OUTPUT: __metrics 13:47:58 INFO - 2015-12-28 13:47:58,164 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:47:59 INFO - 2015-12-28 13:47:59,373 INFO : Browser initialized. 13:47:59 INFO - 2015-12-28 13:47:59,374 INFO : Running cycle 1/1 for v8_7 test... 13:47:59 INFO - 2015-12-28 13:47:59,374 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpuC5mdt/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:48:10 INFO - 2015-12-28 13:48:10,936 DEBUG : BROWSER_OUTPUT: RSS: Main: 128266240 13:48:10 INFO - 2015-12-28 13:48:10,936 DEBUG : BROWSER_OUTPUT: 13:48:32 INFO - 2015-12-28 13:48:32,347 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57427/tests/v8_7/run.html (next: http://localhost:57427/tests/v8_7/run.html) 13:48:32 INFO - 2015-12-28 13:48:32,597 DEBUG : BROWSER_OUTPUT: RSS: Main: 419586048 13:48:32 INFO - 2015-12-28 13:48:32,597 DEBUG : BROWSER_OUTPUT: 13:48:32 INFO - 2015-12-28 13:48:32,598 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:48:32 INFO - 2015-12-28 13:48:32,599 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:48:32 INFO - 2015-12-28 13:48:32,599 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:48:32 INFO - 2015-12-28 13:48:32,599 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:48:32 INFO - 2015-12-28 13:48:32,599 DEBUG : BROWSER_OUTPUT: |0;Richards;163.96130513198884 13:48:32 INFO - 2015-12-28 13:48:32,599 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;164.88046166529267 13:48:32 INFO - 2015-12-28 13:48:32,599 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.3476310625175 13:48:32 INFO - 2015-12-28 13:48:32,599 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4985.074626865671 13:48:32 INFO - 2015-12-28 13:48:32,599 DEBUG : BROWSER_OUTPUT: |4;RayTrace;941.6195856873823 13:48:32 INFO - 2015-12-28 13:48:32,599 DEBUG : BROWSER_OUTPUT: |5;Earley;553.4034311012729 13:48:32 INFO - 2015-12-28 13:48:32,599 DEBUG : BROWSER_OUTPUT: |6;Boyer;10479.166666666666 13:48:32 INFO - 2015-12-28 13:48:32,600 DEBUG : BROWSER_OUTPUT: |7;RegExp;23534.883720930233 13:48:32 INFO - 2015-12-28 13:48:32,600 DEBUG : BROWSER_OUTPUT: |8;Splay;532.4813631522896 13:48:32 INFO - 2015-12-28 13:48:32,600 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4822.115384615385 13:48:32 INFO - 2015-12-28 13:48:32,600 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:48:32 INFO - 2015-12-28 13:48:32,600 DEBUG : BROWSER_OUTPUT: __startTimestamp1451339312597__endTimestamp 13:48:32 INFO - 2015-12-28 13:48:32,600 DEBUG : BROWSER_OUTPUT: 13:48:32 INFO - 2015-12-28 13:48:32,600 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:48:32 INFO - 2015-12-28 13:48:32,600 DEBUG : BROWSER_OUTPUT: Number of tests: 10 13:48:32 INFO - 2015-12-28 13:48:32,600 DEBUG : BROWSER_OUTPUT: 13:48:32 INFO - 2015-12-28 13:48:32,601 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:163.96 Median:163.96 stddev:0.00 (0.0%) 13:48:32 INFO - 2015-12-28 13:48:32,601 DEBUG : BROWSER_OUTPUT: Values: 164.0 13:48:32 INFO - 2015-12-28 13:48:32,601 DEBUG : BROWSER_OUTPUT: 13:48:32 INFO - 2015-12-28 13:48:32,601 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:164.88 Median:164.88 stddev:0.00 (0.0%) 13:48:32 INFO - 2015-12-28 13:48:32,601 DEBUG : BROWSER_OUTPUT: Values: 164.9 13:48:32 INFO - 2015-12-28 13:48:32,601 DEBUG : BROWSER_OUTPUT: 13:48:32 INFO - 2015-12-28 13:48:32,601 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.35 Median:280.35 stddev:0.00 (0.0%) 13:48:32 INFO - 2015-12-28 13:48:32,601 DEBUG : BROWSER_OUTPUT: Values: 280.3 13:48:32 INFO - 2015-12-28 13:48:32,601 DEBUG : BROWSER_OUTPUT: 13:48:32 INFO - 2015-12-28 13:48:32,602 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4985.07 Median:4985.07 stddev:0.00 (0.0%) 13:48:32 INFO - 2015-12-28 13:48:32,602 DEBUG : BROWSER_OUTPUT: Values: 4985.1 13:48:32 INFO - 2015-12-28 13:48:32,602 DEBUG : BROWSER_OUTPUT: 13:48:32 INFO - 2015-12-28 13:48:32,602 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:941.62 Median:941.62 stddev:0.00 (0.0%) 13:48:32 INFO - 2015-12-28 13:48:32,603 DEBUG : BROWSER_OUTPUT: Values: 941.6 13:48:32 INFO - 2015-12-28 13:48:32,604 DEBUG : BROWSER_OUTPUT: 13:48:32 INFO - 2015-12-28 13:48:32,604 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:553.40 Median:553.40 stddev:0.00 (0.0%) 13:48:32 INFO - 2015-12-28 13:48:32,604 DEBUG : BROWSER_OUTPUT: Values: 553.4 13:48:32 INFO - 2015-12-28 13:48:32,604 DEBUG : BROWSER_OUTPUT: 13:48:32 INFO - 2015-12-28 13:48:32,604 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10479.17 Median:10479.17 stddev:0.00 (0.0%) 13:48:32 INFO - 2015-12-28 13:48:32,604 DEBUG : BROWSER_OUTPUT: Values: 10479.2 13:48:32 INFO - 2015-12-28 13:48:32,604 DEBUG : BROWSER_OUTPUT: 13:48:32 INFO - 2015-12-28 13:48:32,604 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:23534.88 Median:23534.88 stddev:0.00 (0.0%) 13:48:32 INFO - 2015-12-28 13:48:32,604 DEBUG : BROWSER_OUTPUT: Values: 23534.9 13:48:32 INFO - 2015-12-28 13:48:32,604 DEBUG : BROWSER_OUTPUT: 13:48:32 INFO - 2015-12-28 13:48:32,604 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:532.48 Median:532.48 stddev:0.00 (0.0%) 13:48:32 INFO - 2015-12-28 13:48:32,604 DEBUG : BROWSER_OUTPUT: Values: 532.5 13:48:32 INFO - 2015-12-28 13:48:32,604 DEBUG : BROWSER_OUTPUT: 13:48:32 INFO - 2015-12-28 13:48:32,604 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 13:48:32 INFO - 2015-12-28 13:48:32,604 DEBUG : BROWSER_OUTPUT: Values: 4822.1 13:48:32 INFO - 2015-12-28 13:48:32,604 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:48:32 INFO - 2015-12-28 13:48:32,605 DEBUG : BROWSER_OUTPUT: 13:48:33 INFO - 2015-12-28 13:48:33,281 INFO : Browser exited with error code: 0 13:48:33 INFO - 2015-12-28 13:48:33,298 INFO : Completed test v8_7 (00:00:39) 13:48:33 INFO - 2015-12-28 13:48:33,612 INFO : Completed test suite (00:20:07) 13:48:33 INFO - 2015-12-28 13:48:33,613 DEBUG : Working with test: dromaeo_css 13:48:33 INFO - 2015-12-28 13:48:33,613 DEBUG : Generating results file: dromaeo_css 13:48:33 INFO - 2015-12-28 13:48:33,615 DEBUG : Working with test: kraken 13:48:33 INFO - 2015-12-28 13:48:33,615 DEBUG : Generating results file: kraken 13:48:33 INFO - 2015-12-28 13:48:33,615 INFO : javascript benchmark 13:48:33 INFO - 2015-12-28 13:48:33,615 DEBUG : Working with test: v8_7 13:48:33 INFO - 2015-12-28 13:48:33,616 DEBUG : Generating results file: v8_7 13:48:33 INFO - 2015-12-28 13:48:33,616 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:48:33 INFO - 2015-12-28 13:48:33,666 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,53,35]] 13:48:33 INFO - 2015-12-28 13:48:33,666 DEBUG : process_Request line: dromaeo_css 7183.72 graph.html#tests=[[72,53,35]] 13:48:33 INFO - 2015-12-28 13:48:33,666 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:48:33 INFO - 2015-12-28 13:48:33,701 DEBUG : process_Request line: kraken 1465.10 graph.html#tests=[[232,53,35]] 13:48:33 INFO - 2015-12-28 13:48:33,701 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:48:33 INFO - 2015-12-28 13:48:33,738 DEBUG : process_Request line: v8_7 23429.57 graph.html#tests=[[230,53,35]] 13:48:33 INFO - 2015-12-28 13:48:33,739 INFO : javascript benchmark 13:48:33 INFO - 2015-12-28 13:48:33,742 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3262.200760813601, 3315.4695248760204, 3333.483310086936, 3344.7658663893535, 3360.4623260278354, 5558.805441809537, 5565.053940830058, 5591.916121258185, 5617.129344951529, 5620.91568626471, 5570.944290557093, 5575.609707320489, 5595.908797784434, 5600.6079574429805, 5618.325800903887, 5037.0, 5108.489151084889, 5149.588032957355, 5158.742062896859, 5231.0, 5069.087564238435, 5078.847634570969, 5176.275321454999, 5179.870503237412, 5235.764390602432, 5164.819231326905, 5181.948180518184, 5215.86960325993, 5219.347581552306, 5243.6853788772605, 5154.716490593016, 5178.456262092502, 5219.973900130494, 5248.81629142982, 5255.710935898524, 5068.4424713281505, 5091.592672586185, 5115.820946266863, 5118.334616499868, 5163.793448262065, 5466.835994920159, 5478.808241711561, 5488.890222195574, 5493.835184944418, 5543.417941116206, 5975.731092100866, 6198.4731297839735, 6203.875922481525, 6213.627182369072, 6215.7513699451965, 6026.156338112668, 6077.942788796952, 6094.116353128816, 6097.146399504073, 6117.296510901258, 5725.169850371714, 5731.799387021434, 5735.942640573582, 5737.8565535861935, 5750.2237197978575, 5983.311919129269, 6083.239595050619, 6177.135201071854, 6216.689165541705, 6220.098085777537, 5885.028970219952, 5926.496247818897, 5981.551383646244, 5995.340512543617, 6026.969865150734, 6113.38866113394, 6127.571070025145, 6141.631502109888, 6161.969190154021, 6168.753249870045, 5922.052471604523, 6046.818595442144, 6057.0, 6120.908186377208, 6135.938640613536, 6127.997769102053, 6131.570790044654, 6140.0, 6141.785037523665, 6158.137860699506, 4686.906261874743, 4692.6245900327895, 4706.929396059062, 4710.199266124767, 4723.504032076651, 4117.649999750055, 4123.299039163349, 4196.328587425997, 4201.2017716633745, 4224.302990006615, 5837.708114594253, 5854.677992710442, 5858.238429004287, 5867.149263356875, 5871.853203669943, 6178.227721534809, 6192.349803270682, 6197.03945888388, 6201.844953876099, 6205.100260462298, 5633.521150702154, 5648.491635752802, 5705.657660540381, 5711.971440142773, 5732.3407808101765, 5264.6051546134195, 5319.760610772524, 5327.067763141435, 5333.386660534011, 5348.064088784447, 6117.785877494266, 6355.523335749837, 6374.394432528902, 6379.64911929839, 6387.137736405619, 6051.636901785819, 6077.787277445268, 6143.771245750957, 6158.846028849314, 6162.22972128484, 6302.0, 6322.46259067966, 6331.366863313632, 6334.809955701337, 6346.01636746305, 5798.56510761703, 5905.793297234576, 6060.90908636362, 6062.5453091019235, 6074.787382441594, 6126.356732543019, 6219.595726277958, 6230.937690623035, 6236.438720515175, 6243.875122497616, 5972.761089556369, 5983.790567330297, 5987.64074155552, 5997.190379298739, 6028.457438830526, 5747.856303592276, 5852.356240813422, 5978.880422391615, 5986.850328741816, 5998.940010600013, 5724.513416359656, 5803.071508558611, 5806.071028635398, 5806.912896306474, 5832.737526811388, 5953.196318497121, 5973.104034394875, 5993.520518358608, 5999.4600485954725, 6004.819855404345, 5618.971905140448, 5710.942890571041, 5719.084946408555, 5910.911336329872, 5922.1412895130825], "unit": "ms", "name": "dojo.html", "value": 5611.123257356729}, {"lowerIsBetter": false, "replicates": [603.6679826095647, 626.5833220908094, 631.7378288010476, 635.7361694896618, 649.886269902767, 42559.36160957584, 42977.140457190835, 43117.35323970143, 43164.0, 43179.56820431795, 46323.53676463234, 47007.29489057667, 47010.76494617522, 47020.29469557959, 47164.0, 8324.66701331946, 8405.537695426749, 9144.542772861363, 9312.255019598417, 10486.370817750922, 10643.095336896373, 10722.410267435327, 10761.30051546647, 10770.084542813871, 10782.514786834572, 10785.191110666692, 10918.0, 10918.836217456745, 10925.726856828604, 10929.125669946385, 10630.096441802418, 10714.142868570574, 10723.946380268088, 10728.249022568423, 10733.355998640067, 10672.413017284047, 10787.244892857503, 10793.5682572697, 10795.08241799448, 10804.0816530595, 42920.57079429197, 43290.567094328966, 43393.13213735739, 43474.56525434737, 43485.13029739419, 3462.3075384922863, 3594.245208506217, 3597.1007248187952, 4126.360414135814, 4147.8963025924595, 32610.673893261002, 32872.3425531488, 33180.50229246539, 33265.334693305995, 33472.3305533888, 3784.3377408953324, 3850.4801851750217, 3859.4982652255308, 3878.7672739635714, 3924.7645141291614, 316926.0, 318165.0, 319721.0, 320094.0, 320249.9999999977, 65429.0, 66894.66552667302, 69133.65433172902, 69594.65202673954, 69595.0, 73511.26488735044, 74226.0, 74682.25317746753, 74859.62570187222, 75047.24952750403, 16424.260908259155, 16488.505344839676, 16581.83418165803, 16607.08661023631, 16629.584260393585, 13854.0, 13925.582232533041, 13927.025108242326, 13932.373043212878, 13952.16287022782, 22152.335429937128, 22659.187265018758, 22659.773402266095, 22692.20577279787, 22785.430364241027, 8413.70552030676, 8676.262517686067, 8722.215000649972, 8740.519271440131, 8745.956270218609, 1029.917606591471, 1069.8823129455754, 1109.051760744568, 1134.733337665648, 1152.8386025956372, 30084.097477075724, 30441.23896902595, 30958.101143421398, 31119.68880311213, 31296.21759455986, 1186.6736647422028, 1187.9584214552622, 1208.8851559101872, 1213.2114125818289, 1215.465195314059, 14713.92643036778, 16170.110643914697, 17280.827191728175, 17636.38272660451, 18017.459476215736, 470921.0, 471094.0, 471640.0, 472381.0, 472786.0, 61899.69050154721, 62828.37171628317, 62890.0, 63498.6825065881, 63594.36405635977, 1372.8078069070339, 1393.5540626999466, 1479.977800332996, 1509.7659862721296, 1559.2593518078822, 30928.381432370777, 30972.535411968387, 30997.39341462691, 31459.528107077953, 31846.203844904063, 48883.0, 49334.0, 49340.50659493359, 49387.0, 49460.258096127865, 324704.0, 325980.0, 327362.0, 328388.0, 329057.0, 35809.82095089508, 36235.45646815353, 36297.81851090727, 36509.634903651684, 36826.63173368232, 45744.31383529183, 46395.76802115968, 46927.0, 47052.0, 47225.763871180425, 38956.0, 39729.0, 39799.403008955465, 40294.0, 40780.59219407768, 43653.0, 46125.76937115293, 46622.0, 46720.29919551277, 47192.528074718815, 40624.519686054926, 41236.79381603073, 41366.793166033975, 41397.79301103475, 41468.79265603652, 34898.82550587231, 34951.65018396418, 35755.0, 35958.460623091196, 36416.27167456583, 27125.457490850466, 27733.44533109367, 27927.16218513448, 28067.578986314813, 28142.859285703442], "unit": "ms", "name": "ext.html", "value": 21078.121268335693}, {"lowerIsBetter": false, "replicates": [376.3564305038384, 377.46400111841183, 384.9172427927996, 386.4493097336295, 391.2819975345241, 13946.651333716662, 14169.645758856008, 19114.90442547787, 20825.583488330245, 20856.582868342644, 13318.40067196976, 13680.657983550416, 13684.042117051811, 19812.70280945787, 20130.0, 4733.928991065128, 4880.829170979016, 4887.413510378742, 4898.044881248158, 4898.975505122487, 4841.346418233528, 4875.414950205963, 4882.462929077798, 4885.291632713254, 4890.997345544155, 3895.7467764595212, 4842.41890973082, 4846.0550192712435, 4848.0, 4947.9505204947845, 5208.8958220835375, 5257.921131183035, 5260.736963151827, 5264.763085661135, 5272.024675435037, 4483.843065492725, 4571.3600095986585, 4576.931346029813, 4583.404157459542, 4588.0365123324145, 14951.626209344853, 15268.236588170546, 15378.769318460232, 15525.534233972887, 15533.223338833126, 1972.8125828046457, 2062.412212519425, 2181.9127234910584, 2211.7788221177916, 2239.3505883293824, 11047.226694131414, 11185.440727963569, 11236.438178091063, 11289.040431563328, 11491.253068550517, 1747.0478589168933, 1808.6744386010512, 1880.8401285890716, 1973.930912418073, 2017.9495512612154, 64323.678381607795, 71509.0, 71734.0, 73655.63172184158, 73791.0, 7938.483998540077, 8024.2376974187355, 8025.959870200729, 8080.474769139987, 8087.838243235103, 9705.369151005161, 9714.077162669535, 9730.95134524323, 9735.123838854537, 9735.464549449849, 6394.104825324458, 6466.06242094903, 6479.0, 6492.123563318986, 6493.740250389931, 6731.697073631698, 6748.257691653914, 6752.898706519406, 6772.559783614148, 6810.659467026629, 3682.931949734547, 3706.8887933362043, 3707.1288247261873, 3730.0488375464083, 3734.6452087051684, 1273.1215461331838, 1277.2272774971195, 1287.5043108403331, 1309.4369421148997, 1323.8676132386684, 483.6445212768612, 494.7130664214747, 529.8595872093898, 534.3667753711863, 567.1011446856696, 12698.80951785724, 13045.217286962812, 13873.930630346784, 13941.0, 14099.647508812363, 505.5147058823497, 568.0541897740299, 572.3418069220346, 585.7100735136135, 595.1756816808664, 7031.718731250795, 7285.307895749896, 7287.089113860768, 7375.483716139819, 7439.479236453504, 641776.0, 645791.0, 647085.0, 648089.0, 666777.0, 90087.0, 90585.0, 92589.0, 94310.0, 95201.52399237959, 631.5547538985005, 633.5153607490273, 635.8346829824279, 636.7643971730489, 636.8917284061721, 11954.103442241692, 12133.817992729939, 12280.75438491243, 12321.383930803604, 12325.445354959227, 36850.44724329191, 37497.2500549982, 37613.2477350446, 38594.6140538591, 41535.0, 53242.46757532375, 54458.18312725391, 55059.17411238755, 55701.0, 55968.44031559632, 7367.0, 7474.289942455458, 7582.128055273714, 7600.46796724224, 7604.657790399335, 13206.867931320563, 13499.73000539964, 13556.59330220095, 13585.728285434434, 13630.1140425872, 11610.535578576762, 11797.587084452003, 12027.939860300992, 12047.819282710941, 12093.455794489446, 11125.944370278097, 11239.719007024889, 11375.488103035217, 11541.192116551762, 11603.36181510025, 10399.94800025995, 12157.331346776013, 12356.25862448256, 12513.0, 12658.683532911382, 6980.755673551402, 7424.294692004251, 7568.659410326439, 7591.089069311718, 7652.80867978305, 12075.637730868088, 12137.635870923887, 12289.201201921847, 12303.077269205025, 12540.310282934526], "unit": "ms", "name": "jquery.html", "value": 7748.317668109821}, {"lowerIsBetter": false, "replicates": [1534.647031182828, 1539.0457916092025, 1724.9396271130513, 1818.73628323893, 1846.0677357934246, 7352.301531354527, 7510.737124200654, 7867.1739467355965, 7976.999999999993, 8006.91993080069, 7702.8844567331535, 7911.406644501657, 8032.839343213132, 8038.356931445485, 8045.115037345888, 2255.041607316892, 2268.0360846640197, 2275.0217406515194, 2282.6461898405773, 2288.096202000209, 2046.2428901306537, 2101.674240492726, 2189.2994241842616, 2247.1236217875044, 2342.16853017179, 2180.7165068541067, 2205.724284464442, 2212.3694746997107, 2212.8008479236864, 2213.1921848525253, 2390.1873363056557, 2406.5427568761966, 2407.2296865003204, 2407.4944261705064, 2410.614301711735, 2294.4263934016494, 2361.1853910401055, 2362.2795047510504, 2363.066588697455, 2363.2083252110565, 8016.358691304682, 8036.35709143273, 8060.838783224362, 8105.1489593593005, 8107.95946020272, 4810.06203790261, 4927.90144197114, 4950.034743225073, 4961.950380496185, 4964.404271487409, 3234.9029529113927, 3241.1086951088405, 3287.8356082195796, 3300.0, 3301.851416686255, 1064.5262858028182, 1071.710638127709, 1098.1544210957597, 1100.7963526747578, 1141.8173092305192, 11092.833607495893, 11097.667069987914, 11098.500567474483, 11099.0, 11104.056155226815, 4541.568550987651, 4549.613282870993, 4592.816287348469, 4595.770211489412, 4606.539346065367, 9426.811463770686, 9459.148676619, 9462.148406643435, 9462.29032822541, 9479.76300592477, 5041.294218809369, 5061.8734531637, 5062.974685126551, 5071.543561079447, 5079.492050794965, 4640.489546149921, 4646.4191976003, 4647.024124933734, 4653.976730116396, 4654.162250794821, 3769.849206031783, 3800.6959443244473, 3823.5794062653085, 3831.1379939513945, 3849.9037524062123, 1143.274020996673, 1170.473287020827, 1211.5214490276467, 1274.9107562470538, 1313.0611612696966, 1182.722060315825, 1187.091874715843, 1239.0149830884468, 1482.8887833412537, 1503.6090616439803, 7691.615419229016, 7717.498362606412, 7782.494137881133, 7784.883226751604, 7792.41556883236, 1204.602481181208, 1215.0583297944163, 1218.8842060004463, 1220.5911019808286, 1223.932683702387, 6227.813165605039, 6267.122602835607, 6308.968455157787, 6328.272248691367, 6338.080978258219, 9575.808483830284, 9876.950615246878, 9881.851772223423, 9882.4564648945, 9890.258230632731, 9576.616935322509, 9746.561404736804, 9771.31600787938, 9772.413655180711, 9776.804463910681, 7649.885251721229, 7678.808029799188, 7683.5774032427635, 7699.653515591812, 7708.421868359896, 7355.485116041826, 7395.260473952561, 7470.178280389261, 7471.0, 7521.247875212435, 8694.39139260271, 8774.692885748967, 8791.604377803142, 8816.162464565856, 8876.689315873913, 8872.689455869013, 8993.28053755685, 9017.864732028893, 9035.728928132166, 9118.042605526323, 7137.429005679637, 7141.607211603412, 7184.209736928829, 7187.209406965334, 7188.784336469915, 7019.087518622547, 7728.4590078693955, 7901.249381308767, 7936.841263174589, 7969.242921922408, 6903.102596662402, 7122.287771222836, 7511.3615342696485, 7595.278448547379, 7631.122420921665, 7290.526115802668, 7377.077865266841, 7399.0, 7449.329560339595, 7468.775936721907, 7452.329290363893, 7454.515456495311, 7474.476786625101, 7518.661660225193, 7527.774166775005, 6815.93184068153, 6817.795466136024, 6822.215445223863, 6830.5218634697085, 6885.1049363582415, 6886.345797149263, 6919.169699636076, 6939.0, 6939.965300173467, 6942.583444993316], "unit": "ms", "name": "mootools.html", "value": 4714.348553479073}, {"lowerIsBetter": false, "replicates": [368.3075817463169, 369.3241368296018, 370.377765354205, 371.2056199732571, 377.739359841709, 5858.20914176586, 5944.405559444053, 5967.940320596793, 5974.522038236947, 5974.910376344353, 5804.854878628036, 5863.472287494124, 5893.174955506232, 5901.970490147543, 5910.734016969236, 4678.672492925497, 4680.672352935296, 4681.859544213679, 4682.836100736458, 4684.906301873952, 4684.180268453024, 4684.531546845323, 4688.601468875133, 4690.507496712848, 4693.624510039189, 4586.44962604488, 4657.6273898088075, 4697.8590642280615, 4710.670253082286, 4717.787699553528, 4699.036697477009, 4702.130105930414, 4708.505606911259, 4719.882002949919, 4728.0, 4009.29837278478, 4181.937270940938, 4187.099773548671, 4192.140611174702, 4210.45264115666, 5529.917051244234, 5561.6663000220115, 5571.470710282517, 5579.0515612346, 5593.3847276799515, 5377.516023557899, 5397.4062853086525, 5406.0, 5413.458654134555, 5414.675119492804, 6272.56092073555, 6277.717502712343, 6278.4035516625845, 6278.623282603058, 6301.590396624205, 4501.032278060233, 4578.198815207359, 4581.541845815392, 4589.1968905441745, 4614.838480653195, 6486.513511486657, 6518.771842985473, 6546.770863019819, 6548.476121910236, 6554.93445065548, 4778.689385189951, 4788.904221915543, 4793.304970779287, 4793.856184314476, 4794.856154315376, 4779.450363208206, 4850.53919877611, 4851.272309153655, 4861.659683822169, 4862.854114376574, 5397.595180361489, 5399.784008639689, 5400.378956419983, 5407.513323800877, 5408.594355423359, 6314.557980941382, 6352.523560732963, 6352.61884286935, 6367.235931688135, 6379.234491861006, 1734.9392771252947, 1760.1551255397226, 1761.0490335219095, 1761.11944027986, 1761.3218910719208, 1183.7750827342777, 1206.2280140709952, 1206.6138835572708, 1209.8064309710403, 1237.1154624443566, 6205.47253483459, 6214.782482613087, 6216.471599913967, 6224.470919971853, 6229.937700622936, 6515.51133664977, 6540.37866402691, 6542.738290468423, 6549.836254093686, 6573.408393244536, 6076.817695469143, 6177.351378105324, 6178.567500274938, 6184.072389141665, 6186.938130618726, 3587.982060089735, 3611.223586928823, 3617.7105831533413, 3621.149029977953, 3626.111602657366, 6609.768658096944, 6614.669266536654, 6717.093192419059, 6731.461483081342, 6741.292164322774, 6632.369924857131, 6648.634325112165, 6674.599524028574, 6689.933100669028, 6692.564983276072, 6671.832429324946, 6672.79981600543, 6678.131842860397, 6686.297938716365, 6687.899681504781, 6375.203099612549, 6576.112224849775, 6616.7022483987375, 6647.867042659216, 6650.102236198051, 6533.967330163318, 6570.671466426755, 6573.934260657332, 6590.275069742229, 6593.175853018372, 6755.256921738703, 6780.796576102724, 6808.93191068083, 6843.589384636938, 6843.692033858588, 4591.265397536378, 4701.130290896195, 4701.882452938704, 4704.200285951465, 4706.505816889177, 6599.142111525663, 6620.933790662032, 6643.30245324234, 6646.202455705346, 6661.733530658913, 6366.9681651591445, 6414.839629009312, 6417.839554011187, 6422.486201103994, 6423.389777971085, 6228.688565571794, 6233.065040244, 6271.843203919939, 6279.623222606659, 6411.775587854403, 6231.875362492816, 6232.189815323979, 6235.906461403173, 6239.844003899939, 6242.282137554058, 6348.555601107878, 6358.968205158944, 6360.650164241011, 6361.840953976188, 6365.554411191358, 6099.207103076572, 6197.721102550306, 6205.069239614094, 6206.0, 6222.471089957405], "unit": "ms", "name": "prototype.html", "value": 4879.716314378427}, {"lowerIsBetter": false, "replicates": [822.4900561651776, 883.5802993578055, 889.1330952321488, 914.7621618379219, 914.9862752058721, 13284.136531125481, 13356.799648005288, 13679.110857794261, 13700.725985480285, 13724.725505489885, 13041.08712390133, 13140.0, 13160.341982900865, 13169.275689837055, 13172.47310107597, 735.3528894572781, 756.0285033731656, 897.2687259883207, 917.6833992272656, 918.8392031394512, 896.596531560797, 901.1034021148934, 902.0438335364502, 906.2206502407923, 908.3686837647838, 780.2548566119342, 795.6260557537948, 946.4274114160937, 957.5834511987273, 957.8419560772464, 934.7242563443766, 950.4059962523423, 952.3238500664537, 952.5237381309346, 953.0279115302387, 703.5848849178958, 705.6824429006967, 705.9364657180878, 705.9752908648172, 706.3148745716646, 13189.0, 13268.800967985488, 13314.201147931059, 13328.466861325536, 13336.266505342202, 11729.472173752201, 11733.120015998835, 11827.290362578187, 11945.940270298679, 12055.276683399024, 9252.953735231347, 9480.336376453652, 9587.280953928414, 9745.0, 9859.211263098934, 3679.797611131387, 3681.3005528949416, 3691.187938653519, 3716.7026637868908, 3723.6090210527777, 54867.45132548703, 55291.72354138244, 56712.0, 56842.715786420806, 56963.430365696644, 9361.719148425422, 9562.904370956341, 9572.377795443273, 9641.710748677551, 9751.707448776548, 17674.558136046446, 17827.376041838474, 17838.732419013726, 17844.732329015074, 17873.910630446764, 7510.248975102446, 7591.544507329578, 7628.580428076509, 7766.5728384939375, 7818.921810781933, 4262.7016108872085, 4296.033392486665, 4322.913541729148, 4334.349847522833, 4373.825046998148, 3178.268998130443, 3214.0197239842073, 3216.083416226411, 3221.4845624699938, 3222.5971753530807, 484.36548121960345, 496.1045313209691, 502.67577412568687, 505.29511331692817, 509.1802198460476, 521.7078436075734, 648.9578177418452, 706.5689929143322, 721.3760097515611, 727.7125535413483, 8417.410781245377, 9000.8649870252, 9064.320175986828, 9105.2260557852, 9399.953000234955, 478.26824957814597, 597.5996082624652, 601.5278006764669, 656.1830521001384, 657.9046038324416, 4217.8523751668545, 4228.4080228768, 4341.674374421931, 4345.30475123985, 4386.342048692658, 64215.6789216051, 69758.30241697619, 70219.64890175516, 70370.0, 70446.0, 54740.0, 54908.450915491136, 55670.72164639151, 55862.44137558654, 57250.141247881314, 54593.727031364586, 55001.0, 55367.0, 55458.72270638621, 56756.71621641865, 8917.910820891968, 8938.731838044869, 9135.588898499716, 9290.860637090314, 9293.12754631697, 39573.80213098916, 40382.79808600938, 40704.79647601743, 40965.1806963865, 41032.0, 50789.0, 54283.0, 55042.72478637581, 55350.44649553453, 55769.1634625489, 8112.351011919151, 8293.751187464386, 8593.95703021481, 8674.956625216833, 8700.477971321741, 12125.151239413157, 12245.938770306091, 12345.444454999368, 12431.0, 12953.805692914426, 11479.598214062467, 11510.712232193928, 11556.826647600124, 11564.0, 11938.462769175234, 11005.669829905115, 11355.602553910574, 11364.886351136383, 11522.0, 11830.763384732429, 11354.148438867283, 11356.659300221007, 11380.487878045342, 11392.658220253406, 11474.770504589695, 9988.151007164472, 10096.949515252376, 10182.236332275257, 10268.229882758673, 10378.0, 9172.587233574372, 9229.49237791928, 9323.953380233055, 9443.338966272295, 9640.903590964], "unit": "ms", "name": "yui.html", "value": 6518.567256901787}], "name": "dromaeo_css", "value": 7183.720600610743}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 111.0, 103.0, 110.0, 109.0, 110.0, 100.0, 111.0, 111.0, 108.0], "unit": "ms", "name": "ai-astar", "value": 108.1}, {"lowerIsBetter": true, "replicates": [152.0, 122.0, 145.0, 160.0, 132.0, 147.0, 152.0, 122.0, 160.0, 125.0], "unit": "ms", "name": "audio-beat-detection", "value": 141.7}, {"lowerIsBetter": true, "replicates": [163.0, 161.0, 161.0, 162.0, 161.0, 161.0, 161.0, 164.0, 164.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 162.0}, {"lowerIsBetter": true, "replicates": [71.0, 73.0, 72.0, 148.0, 71.0, 72.0, 72.0, 73.0, 154.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 87.9}, {"lowerIsBetter": true, "replicates": [89.0, 91.0, 144.0, 91.0, 90.0, 90.0, 126.0, 89.0, 91.0, 135.0], "unit": "ms", "name": "audio-oscillator", "value": 103.6}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 110.0, 112.0, 110.0, 110.0, 109.0, 110.0, 110.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.9}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.0}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [54.0, 56.0, 56.0, 55.0, 56.0, 56.0, 58.0, 56.0, 53.0, 56.0], "unit": "ms", "name": "json-parse-financial", "value": 55.6}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 64.0, 63.0, 64.0, 63.0, 63.0, 64.0, 64.0, 63.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 63.5}, {"lowerIsBetter": true, "replicates": [79.0, 77.0, 79.0, 79.0, 88.0, 86.0, 80.0, 79.0, 80.0, 79.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 80.6}, {"lowerIsBetter": true, "replicates": [114.0, 108.0, 108.0, 108.0, 116.0, 116.0, 111.0, 110.0, 108.0, 119.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 111.8}, {"lowerIsBetter": true, "replicates": [136.0, 137.0, 134.0, 134.0, 134.0, 138.0, 134.0, 138.0, 135.0, 140.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 136.0}, {"lowerIsBetter": true, "replicates": [63.0, 65.0, 62.0, 63.0, 61.0, 63.0, 62.0, 61.0, 63.0, 63.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 62.6}], "name": "kraken", "value": 1465.0999999999997}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [163.96130513198884], "unit": "score", "name": "Richards", "value": 215.306898}, {"lowerIsBetter": false, "replicates": [164.88046166529267], "unit": "score", "name": "DeltaBlue", "value": 401.0056700000001}, {"lowerIsBetter": false, "replicates": [280.3476310625175], "unit": "score", "name": "Encrypt", "value": 949.4676269999999}, {"lowerIsBetter": false, "replicates": [4985.074626865671], "unit": "score", "name": "Decrypt", "value": 53.39558982035927}, {"lowerIsBetter": false, "replicates": [941.6195856873823], "unit": "score", "name": "RayTrace", "value": 785.8683179999997}, {"lowerIsBetter": false, "replicates": [553.4034311012729], "unit": "score", "name": "Earley", "value": 1204.2986409999994}, {"lowerIsBetter": false, "replicates": [10479.166666666666], "unit": "score", "name": "Boyer", "value": 63.59885487077532}, {"lowerIsBetter": false, "replicates": [23534.883720930233], "unit": "score", "name": "RegExp", "value": 38.70786067193677}, {"lowerIsBetter": false, "replicates": [532.4813631522896], "unit": "score", "name": "Splay", "value": 153.04009800000009}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 23429.573772585118}]} 13:48:33 INFO - RETURN: dromaeo_css: 7183.72 13:48:33 INFO - RETURN: kraken: 1465.10 13:48:33 INFO - RETURN: v8_7: 23429.57 13:48:33 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,53,35]]", "result": "23429.57"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,53,35]]", "result": "1465.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,53,35]]", "result": "7183.72"}}} 13:48:33 INFO - Return code: 0 13:48:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 13:48:33 INFO - # TBPL SUCCESS # 13:48:33 INFO - Running post-action listener: _resource_record_post_action 13:48:33 INFO - Running post-run listener: _resource_record_post_run 13:48:34 INFO - Total resource usage - Wall time: 1223s; CPU: 13.0%; Read bytes: 565248; Write bytes: 274640896; Read time: 72; Write time: 272756 13:48:34 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 19054592; Read time: 0; Write time: 8436 13:48:34 INFO - run-tests - Wall time: 1209s; CPU: 13.0%; Read bytes: 565248; Write bytes: 255586304; Read time: 72; Write time: 264320 13:48:34 INFO - Running post-run listener: _upload_blobber_files 13:48:34 INFO - Blob upload gear active. 13:48:34 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 13:48:34 INFO - Copying logs to upload dir... 13:48:34 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1266.352114 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2015-12-28 13:48:34.929577) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-28 13:48:34.933050) ========= 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=0ae9de487587ba4b94dd3100000001b5-1451337611.323402-376386351 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1451329655/firefox-44.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010026 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1451329655/firefox-44.0.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.05 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-28 13:48:34.988634) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 13:48:34.988991) ========= 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=0ae9de487587ba4b94dd3100000001b5-1451337611.323402-376386351 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004410 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 13:48:35.038445) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-28 13:48:35.038790) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-28 13:48:35.039079) ========= ========= Total master_lag: 0.55 =========