builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-023 starttime: 1450379497.73 results: success (0) buildid: 20151217085230 builduid: b749f8180a314db49d7d0bbc7a2d7e3f revision: ad8706960512 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-17 11:11:37.727814) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-17 11:11:37.728303) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-17 11:11:37.728603) ========= bash -c pwd in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e10134013339c31d8d0c4708000001d6-1450376188.393086-729757505 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006439 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-17 11:11:37.761953) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-17 11:11:37.765485) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-17 11:11:37.789419) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 11:11:37.789831) ========= rm -rf properties in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e10134013339c31d8d0c4708000001d6-1450376188.393086-729757505 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004548 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 11:11:37.852188) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-17 11:11:37.852509) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-17 11:11:37.852897) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 11:11:37.853285) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e10134013339c31d8d0c4708000001d6-1450376188.393086-729757505 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-17 11:11:39-- 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% 220M=0s 2015-12-17 11:11:39 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.107725 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 11:11:37.992665) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 11:11:37.993087) ========= rm -rf scripts in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e10134013339c31d8d0c4708000001d6-1450376188.393086-729757505 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021258 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 11:11:38.051101) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-17 11:11:38.051416) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev ad8706960512 --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 ad8706960512 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e10134013339c31d8d0c4708000001d6-1450376188.393086-729757505 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-17 11:11:39,315 Setting DEBUG logging. 2015-12-17 11:11:39,315 attempt 1/10 2015-12-17 11:11:39,315 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/ad8706960512?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-17 11:11:40,429 unpacking tar archive at: mozilla-beta-ad8706960512/testing/mozharness/ program finished with exit code 0 elapsedTime=1.399358 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-17 11:11:39.467357) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-17 11:11:39.467744) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-17 11:11:39.479893) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-17 11:11:39.480306) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-17 11:11:39.480805) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 32 secs) (at 2015-12-17 11:11:39.481211) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e10134013339c31d8d0c4708000001d6-1450376188.393086-729757505 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:11:40 INFO - MultiFileLogger online at 20151217 11:11:40 in /builds/slave/test-pgo 11:11:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 11:11:40 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 11:11:40 INFO - {'append_to_log': False, 11:11:40 INFO - 'base_work_dir': '/builds/slave/test-pgo', 11:11:40 INFO - 'blob_upload_branch': 'Mozilla-Beta', 11:11:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 11:11:40 INFO - 'branch': 'Mozilla-Beta', 11:11:40 INFO - 'buildbot_json_path': 'buildprops.json', 11:11:40 INFO - 'config_files': ('talos/linux_config.py',), 11:11:40 INFO - 'default_actions': ('clobber', 11:11:40 INFO - 'read-buildbot-config', 11:11:40 INFO - 'download-and-extract', 11:11:40 INFO - 'populate-webroot', 11:11:40 INFO - 'create-virtualenv', 11:11:40 INFO - 'install', 11:11:40 INFO - 'run-tests'), 11:11:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:11:40 INFO - 'download_minidump_stackwalk': True, 11:11:40 INFO - 'download_symbols': 'ondemand', 11:11:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:11:40 INFO - 'tooltool.py': '/tools/tooltool.py', 11:11:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:11:40 INFO - '/tools/misc-python/virtualenv.py')}, 11:11:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:11:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:11:40 INFO - 'installer_path': 'installer.exe', 11:11:40 INFO - 'log_level': 'info', 11:11:40 INFO - 'log_name': 'talos', 11:11:40 INFO - 'log_to_console': True, 11:11:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:11:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:11:40 INFO - 'opt_config_files': (), 11:11:40 INFO - 'pip_index': False, 11:11:40 INFO - 'sps_profile': False, 11:11:40 INFO - 'sps_profile_interval': 0, 11:11:40 INFO - 'suite': 'dromaeojs', 11:11:40 INFO - 'system_bits': '64', 11:11:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:11:40 INFO - 'title': 'talos-linux64-ix-023', 11:11:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:11:40 INFO - 'use_talos_json': True, 11:11:40 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 11:11:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:11:40 INFO - 'work_dir': 'build'} 11:11:40 INFO - ##### 11:11:40 INFO - ##### Running clobber step. 11:11:40 INFO - ##### 11:11:40 INFO - Running pre-action listener: _resource_record_pre_action 11:11:40 INFO - Running main action method: clobber 11:11:40 INFO - rmtree: /builds/slave/test-pgo/build 11:11:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 11:11:41 INFO - Running post-action listener: _resource_record_post_action 11:11:41 INFO - ##### 11:11:41 INFO - ##### Running read-buildbot-config step. 11:11:41 INFO - ##### 11:11:41 INFO - Running pre-action listener: _resource_record_pre_action 11:11:41 INFO - Running main action method: read_buildbot_config 11:11:41 INFO - Using buildbot properties: 11:11:41 INFO - { 11:11:41 INFO - "properties": { 11:11:41 INFO - "buildnumber": 78, 11:11:41 INFO - "product": "firefox", 11:11:41 INFO - "script_repo_revision": "production", 11:11:41 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 11:11:41 INFO - "repository": "", 11:11:41 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 11:11:41 INFO - "buildid": "20151217085230", 11:11:41 INFO - "slavename": "talos-linux64-ix-023", 11:11:41 INFO - "pgo_build": "True", 11:11:41 INFO - "basedir": "/builds/slave/test-pgo", 11:11:41 INFO - "project": "", 11:11:41 INFO - "platform": "ubuntu64_hw", 11:11:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:11:41 INFO - "slavebuilddir": "test", 11:11:41 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 11:11:41 INFO - "branch": "mozilla-beta", 11:11:41 INFO - "repo_path": "releases/mozilla-beta", 11:11:41 INFO - "stage_platform": "linux64-pgo", 11:11:41 INFO - "builduid": "b749f8180a314db49d7d0bbc7a2d7e3f", 11:11:41 INFO - "revision": "ad8706960512" 11:11:41 INFO - }, 11:11:41 INFO - "sourcestamp": { 11:11:41 INFO - "repository": "", 11:11:41 INFO - "hasPatch": false, 11:11:41 INFO - "project": "", 11:11:41 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 11:11:41 INFO - "changes": [ 11:11:41 INFO - { 11:11:41 INFO - "category": null, 11:11:41 INFO - "files": [ 11:11:41 INFO - { 11:11:41 INFO - "url": null, 11:11:41 INFO - "name": "http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450371150/firefox-44.0.en-US.linux-x86_64.tar.bz2" 11:11:41 INFO - } 11:11:41 INFO - ], 11:11:41 INFO - "repository": "", 11:11:41 INFO - "rev": "ad8706960512", 11:11:41 INFO - "who": "sendchange", 11:11:41 INFO - "when": 1450379472, 11:11:41 INFO - "number": 7372635, 11:11:41 INFO - "comments": "Bug 1233314 - beta repacks are failing trying to find checksums file. r=mshal, a=ritu", 11:11:41 INFO - "project": "", 11:11:41 INFO - "at": "Thu 17 Dec 2015 11:11:12", 11:11:41 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 11:11:41 INFO - "revlink": "", 11:11:41 INFO - "properties": [ 11:11:41 INFO - [ 11:11:41 INFO - "buildid", 11:11:41 INFO - "20151217085230", 11:11:41 INFO - "Change" 11:11:41 INFO - ], 11:11:41 INFO - [ 11:11:41 INFO - "builduid", 11:11:41 INFO - "b749f8180a314db49d7d0bbc7a2d7e3f", 11:11:41 INFO - "Change" 11:11:41 INFO - ], 11:11:41 INFO - [ 11:11:41 INFO - "pgo_build", 11:11:41 INFO - "True", 11:11:41 INFO - "Change" 11:11:41 INFO - ] 11:11:41 INFO - ], 11:11:41 INFO - "revision": "ad8706960512" 11:11:41 INFO - } 11:11:41 INFO - ], 11:11:41 INFO - "revision": "ad8706960512" 11:11:41 INFO - } 11:11:41 INFO - } 11:11:41 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450371150/firefox-44.0.en-US.linux-x86_64.tar.bz2. 11:11:41 INFO - Running post-action listener: _resource_record_post_action 11:11:41 INFO - ##### 11:11:41 INFO - ##### Running download-and-extract step. 11:11:41 INFO - ##### 11:11:41 INFO - Running pre-action listener: _resource_record_pre_action 11:11:41 INFO - Running main action method: download_and_extract 11:11:41 INFO - mkdir: /builds/slave/test-pgo/build/tests 11:11:41 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')]} 11:11:41 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450371150/test_packages.json 11:11:41 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450371150/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 11:11:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450371150/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 11:11:41 INFO - Downloaded 1270 bytes. 11:11:41 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 11:11:41 INFO - Using the following test package requirements: 11:11:41 INFO - {u'common': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip'], 11:11:41 INFO - u'cppunittest': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 11:11:41 INFO - u'firefox-44.0.en-US.linux-x86_64.cppunittest.tests.zip'], 11:11:41 INFO - u'jittest': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 11:11:41 INFO - u'jsshell-linux-x86_64.zip'], 11:11:41 INFO - u'mochitest': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 11:11:41 INFO - u'firefox-44.0.en-US.linux-x86_64.mochitest.tests.zip'], 11:11:41 INFO - u'mozbase': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip'], 11:11:41 INFO - u'reftest': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 11:11:41 INFO - u'firefox-44.0.en-US.linux-x86_64.reftest.tests.zip'], 11:11:41 INFO - u'talos': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 11:11:41 INFO - u'firefox-44.0.en-US.linux-x86_64.talos.tests.zip'], 11:11:41 INFO - u'web-platform': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 11:11:41 INFO - u'firefox-44.0.en-US.linux-x86_64.web-platform.tests.zip'], 11:11:41 INFO - u'webapprt': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip'], 11:11:41 INFO - u'xpcshell': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 11:11:41 INFO - u'firefox-44.0.en-US.linux-x86_64.xpcshell.tests.zip']} 11:11:41 INFO - Downloading packages: [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:11:41 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')]} 11:11:41 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450371150/firefox-44.0.en-US.linux-x86_64.common.tests.zip 11:11:41 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450371150/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 11:11:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450371150/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 11:11:45 INFO - Downloaded 22570901 bytes. 11:11:45 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 11:11:45 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip 11:11:45 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 11:11:46 INFO - Return code: 0 11:11:46 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 11:11:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:11:46 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450371150/firefox-44.0.en-US.linux-x86_64.common.tests.zip 11:11:46 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450371150/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 11:11:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450371150/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 11:11:46 INFO - Downloaded 22570901 bytes. 11:11:46 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 11:11:46 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip 11:11:46 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 11:11:48 INFO - Return code: 0 11:11:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:11:48 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450371150/firefox-44.0.en-US.linux-x86_64.talos.tests.zip 11:11:48 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450371150/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 11:11:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450371150/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 11:11:50 INFO - Downloaded 11131970 bytes. 11:11:50 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 11:11:50 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.talos.tests.zip 11:11:50 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 11:11:50 INFO - Return code: 0 11:11: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')]} 11:11:50 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450371150/firefox-44.0.en-US.linux-x86_64.tar.bz2 11:11:50 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450371150/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 11:11:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450371150/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 11:11:55 WARNING - URL Error: http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450371150/firefox-44.0.en-US.linux-x86_64.tar.bz2 11:11:55 INFO - Running command: ['nslookup', 'archive.mozilla.org'] 11:11:55 INFO - Copy/paste: nslookup archive.mozilla.org 11:11:55 INFO - Server: 10.26.75.40 11:11:55 INFO - Address: 10.26.75.40#53 11:11:55 INFO - archive.mozilla.org canonical name = d34chcsvb7ug62.cloudfront.net. 11:11:55 INFO - Name: d34chcsvb7ug62.cloudfront.net 11:11:55 INFO - Address: 54.192.116.222 11:11:55 INFO - Return code: 0 11:11:55 INFO - retry: attempt #1 caught exception: 11:11:55 INFO - retry: Failed, sleeping 30 seconds before retrying 11:12:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450371150/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 #2 11:12:27 INFO - Downloaded 56620297 bytes. 11:12:27 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450371150/firefox-44.0.en-US.linux-x86_64.tar.bz2 11:12:27 INFO - mkdir: /builds/slave/test-pgo/properties 11:12:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 11:12:27 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 11:12:27 INFO - Contents: 11:12:27 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450371150/firefox-44.0.en-US.linux-x86_64.tar.bz2 11:12:27 INFO - Running post-action listener: _resource_record_post_action 11:12:27 INFO - Running post-action listener: set_extra_try_arguments 11:12:27 INFO - ##### 11:12:27 INFO - ##### Running populate-webroot step. 11:12:27 INFO - ##### 11:12:27 INFO - Running pre-action listener: _resource_record_pre_action 11:12:27 INFO - Running main action method: populate_webroot 11:12:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:12:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:12:27 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 11:12:27 INFO - '../fennec_ids.txt'], 11:12:27 INFO - 'tests': ['tcheck2']}, 11:12:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:12:27 INFO - '--tppagecycles', 11:12:27 INFO - '7'], 11:12:27 INFO - 'tests': ['tsvgm']}}, 11:12:27 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:12:27 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:12:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:12:27 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:12:27 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:12:27 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:12:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:12:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:27 INFO - 'talos_options': ['--e10s'], 11:12:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:12:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:27 INFO - 'tests': ['damp', 'tps']}, 11:12:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:27 INFO - 'talos_options': ['--e10s'], 11:12:27 INFO - 'tests': ['damp', 'tps']}, 11:12:27 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:12:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:12:27 INFO - 'other': {'tests': ['a11yr', 11:12:27 INFO - 'ts_paint', 11:12:27 INFO - 'tpaint', 11:12:27 INFO - 'sessionrestore', 11:12:27 INFO - 'sessionrestore_no_auto_restore']}, 11:12:27 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:12:27 INFO - 'tests': ['a11yr', 11:12:27 INFO - 'ts_paint', 11:12:27 INFO - 'tpaint', 11:12:27 INFO - 'sessionrestore', 11:12:27 INFO - 'sessionrestore_no_auto_restore']}, 11:12:27 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:12:27 INFO - 'tests': ['a11yr', 11:12:27 INFO - 'ts_paint', 11:12:27 INFO - 'tpaint', 11:12:27 INFO - 'sessionrestore', 11:12:27 INFO - 'sessionrestore_no_auto_restore']}, 11:12:27 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:12:27 INFO - 'tests': ['a11yr', 11:12:27 INFO - 'ts_paint', 11:12:27 INFO - 'tpaint', 11:12:27 INFO - 'sessionrestore', 11:12:27 INFO - 'sessionrestore_no_auto_restore']}, 11:12:27 INFO - 'other_l64': {'tests': ['a11yr', 11:12:27 INFO - 'ts_paint', 11:12:27 INFO - 'tpaint', 11:12:27 INFO - 'sessionrestore', 11:12:27 INFO - 'sessionrestore_no_auto_restore']}, 11:12:27 INFO - 'other_nol64': {'tests': ['a11yr', 11:12:27 INFO - 'ts_paint', 11:12:27 INFO - 'tpaint', 11:12:27 INFO - 'sessionrestore', 11:12:27 INFO - 'sessionrestore_no_auto_restore']}, 11:12:27 INFO - 'svgr': {'tests': ['tsvgx', 11:12:27 INFO - 'tsvgr_opacity', 11:12:27 INFO - 'tart', 11:12:27 INFO - 'tscrollx', 11:12:27 INFO - 'cart']}, 11:12:27 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:12:27 INFO - 'tests': ['tsvgx', 11:12:27 INFO - 'tsvgr_opacity', 11:12:27 INFO - 'tart', 11:12:27 INFO - 'tscrollx', 11:12:27 INFO - 'cart']}, 11:12:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:27 INFO - 'tests': ['tp5o']}, 11:12:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:27 INFO - 'talos_options': ['--e10s'], 11:12:27 INFO - 'tests': ['tp5o']}, 11:12:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:27 INFO - 'talos_options': ['--xperf_path', 11:12:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:12:27 INFO - 'tests': ['tp5n']}, 11:12:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:27 INFO - 'talos_options': ['--e10s', 11:12:27 INFO - '--xperf_path', 11:12:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:12:27 INFO - 'tests': ['tp5n']}}, 11:12:27 INFO - 'talos.zip': {'path': '', 11:12:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:12:27 INFO - Running post-action listener: _resource_record_post_action 11:12:27 INFO - ##### 11:12:27 INFO - ##### Running create-virtualenv step. 11:12:27 INFO - ##### 11:12:27 INFO - Running pre-action listener: _resource_record_pre_action 11:12:27 INFO - Running main action method: create_virtualenv 11:12:27 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 11:12:27 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 11:12:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 11:12:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:12:27 INFO - Using real prefix '/usr' 11:12:27 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 11:12:27 INFO - Installing distribute.............................................................................................................................................................................................done. 11:12:29 INFO - Installing pip.................done. 11:12:29 INFO - Return code: 0 11:12:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 11:12: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')]} 11:12:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12: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')]} 11:12:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:29 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 0x7fa23b612f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c5600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1754350>, '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 0x1755250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17556e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1450376188.393086-729757505', '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 11:12:29 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 11:12:29 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 11:12:29 INFO - Using env: {'DISPLAY': ':0', 11:12:29 INFO - 'HOME': '/home/cltbld', 11:12:29 INFO - 'LANG': 'en_US.UTF-8', 11:12:29 INFO - 'LANGUAGE': 'en_US:en', 11:12:29 INFO - 'LOGNAME': 'cltbld', 11:12:29 INFO - 'MAIL': '/var/mail/cltbld', 11:12:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:29 INFO - 'MOZ_NO_REMOTE': '1', 11:12:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:29 INFO - 'NO_EM_RESTART': '1', 11:12:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:12:29 INFO - 'PWD': '/builds/slave/test-pgo', 11:12:29 INFO - 'SHELL': '/bin/bash', 11:12:29 INFO - 'SHLVL': '1', 11:12:29 INFO - 'TERM': 'linux', 11:12:29 INFO - 'TMOUT': '86400', 11:12:29 INFO - 'USER': 'cltbld', 11:12:29 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1450376188.393086-729757505', 11:12:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:29 INFO - '_': '/tools/buildbot/bin/python'} 11:12:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:29 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 11:12:29 INFO - Cleaning up... 11:12:29 INFO - Return code: 0 11:12:29 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 11:12: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')]} 11:12:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12: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')]} 11:12:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:29 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 0x7fa23b612f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c5600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1754350>, '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 0x1755250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17556e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1450376188.393086-729757505', '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 11:12:29 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 11:12:29 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 11:12:29 INFO - Using env: {'DISPLAY': ':0', 11:12:29 INFO - 'HOME': '/home/cltbld', 11:12:29 INFO - 'LANG': 'en_US.UTF-8', 11:12:29 INFO - 'LANGUAGE': 'en_US:en', 11:12:29 INFO - 'LOGNAME': 'cltbld', 11:12:29 INFO - 'MAIL': '/var/mail/cltbld', 11:12:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:29 INFO - 'MOZ_NO_REMOTE': '1', 11:12:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:29 INFO - 'NO_EM_RESTART': '1', 11:12:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:12:29 INFO - 'PWD': '/builds/slave/test-pgo', 11:12:29 INFO - 'SHELL': '/bin/bash', 11:12:29 INFO - 'SHLVL': '1', 11:12:29 INFO - 'TERM': 'linux', 11:12:29 INFO - 'TMOUT': '86400', 11:12:29 INFO - 'USER': 'cltbld', 11:12:29 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1450376188.393086-729757505', 11:12:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:29 INFO - '_': '/tools/buildbot/bin/python'} 11:12:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:30 INFO - Downloading/unpacking psutil>=0.7.1 11:12:30 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 11:12:30 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 11:12:30 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 11:12:30 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 11:12:30 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 11:12:30 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 11:12:31 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 11:12:31 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 11:12:31 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 11:12:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:12:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:12:31 INFO - Installing collected packages: psutil 11:12:31 INFO - Running setup.py install for psutil 11:12:31 INFO - building 'psutil._psutil_linux' extension 11:12:31 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 11:12:32 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 11:12:32 INFO - building 'psutil._psutil_posix' extension 11:12:32 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 11:12:32 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 11:12:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:12:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:12:32 INFO - Successfully installed psutil 11:12:32 INFO - Cleaning up... 11:12:32 INFO - Return code: 0 11:12:32 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 11:12:32 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')]} 11:12:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:32 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')]} 11:12:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:32 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 0x7fa23b612f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c5600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1754350>, '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 0x1755250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17556e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1450376188.393086-729757505', '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 11:12:32 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 11:12:32 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 11:12:32 INFO - Using env: {'DISPLAY': ':0', 11:12:32 INFO - 'HOME': '/home/cltbld', 11:12:32 INFO - 'LANG': 'en_US.UTF-8', 11:12:32 INFO - 'LANGUAGE': 'en_US:en', 11:12:32 INFO - 'LOGNAME': 'cltbld', 11:12:32 INFO - 'MAIL': '/var/mail/cltbld', 11:12:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:32 INFO - 'MOZ_NO_REMOTE': '1', 11:12:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:32 INFO - 'NO_EM_RESTART': '1', 11:12:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:12:32 INFO - 'PWD': '/builds/slave/test-pgo', 11:12:32 INFO - 'SHELL': '/bin/bash', 11:12:32 INFO - 'SHLVL': '1', 11:12:32 INFO - 'TERM': 'linux', 11:12:32 INFO - 'TMOUT': '86400', 11:12:32 INFO - 'USER': 'cltbld', 11:12:32 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1450376188.393086-729757505', 11:12:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:32 INFO - '_': '/tools/buildbot/bin/python'} 11:12:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:32 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:12:32 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 11:12:32 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 11:12:32 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 11:12:32 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 11:12:32 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 11:12:32 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 11:12:34 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:12:34 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 11:12:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:12:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:12:34 INFO - Installing collected packages: mozsystemmonitor 11:12:34 INFO - Running setup.py install for mozsystemmonitor 11:12:34 INFO - Successfully installed mozsystemmonitor 11:12:34 INFO - Cleaning up... 11:12:34 INFO - Return code: 0 11:12:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 11:12:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:34 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 0x7fa23b612f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c5600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1754350>, '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 0x1755250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17556e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1450376188.393086-729757505', '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 11:12:34 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 11:12:34 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 11:12:34 INFO - Using env: {'DISPLAY': ':0', 11:12:34 INFO - 'HOME': '/home/cltbld', 11:12:34 INFO - 'LANG': 'en_US.UTF-8', 11:12:34 INFO - 'LANGUAGE': 'en_US:en', 11:12:34 INFO - 'LOGNAME': 'cltbld', 11:12:34 INFO - 'MAIL': '/var/mail/cltbld', 11:12:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:34 INFO - 'MOZ_NO_REMOTE': '1', 11:12:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:34 INFO - 'NO_EM_RESTART': '1', 11:12:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:12:34 INFO - 'PWD': '/builds/slave/test-pgo', 11:12:34 INFO - 'SHELL': '/bin/bash', 11:12:34 INFO - 'SHLVL': '1', 11:12:34 INFO - 'TERM': 'linux', 11:12:34 INFO - 'TMOUT': '86400', 11:12:34 INFO - 'USER': 'cltbld', 11:12:34 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1450376188.393086-729757505', 11:12:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:34 INFO - '_': '/tools/buildbot/bin/python'} 11:12:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:34 INFO - Downloading/unpacking blobuploader==1.2.4 11:12:34 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 11:12:34 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 11:12:34 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 11:12:34 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 11:12:34 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 11:12:34 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 11:12:36 INFO - Downloading blobuploader-1.2.4.tar.gz 11:12:36 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 11:12:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:12:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:12:36 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 11:12:36 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 11:12:36 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 11:12:36 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 11:12:36 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 11:12:36 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 11:12:36 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 11:12:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 11:12:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:12:36 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 11:12:36 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 11:12:36 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 11:12:36 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 11:12:36 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 11:12:36 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 11:12:37 INFO - Downloading docopt-0.6.1.tar.gz 11:12:37 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 11:12:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 11:12:37 INFO - Installing collected packages: blobuploader, requests, docopt 11:12:37 INFO - Running setup.py install for blobuploader 11:12:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:12:37 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 11:12:37 INFO - Running setup.py install for requests 11:12:37 INFO - Running setup.py install for docopt 11:12:37 INFO - Successfully installed blobuploader requests docopt 11:12:37 INFO - Cleaning up... 11:12:37 INFO - Return code: 0 11:12:37 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:12: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')]} 11:12:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12: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')]} 11:12:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:37 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 0x7fa23b612f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c5600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1754350>, '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 0x1755250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17556e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1450376188.393086-729757505', '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 11:12:37 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 11:12:37 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 11:12:37 INFO - Using env: {'DISPLAY': ':0', 11:12:37 INFO - 'HOME': '/home/cltbld', 11:12:37 INFO - 'LANG': 'en_US.UTF-8', 11:12:37 INFO - 'LANGUAGE': 'en_US:en', 11:12:37 INFO - 'LOGNAME': 'cltbld', 11:12:37 INFO - 'MAIL': '/var/mail/cltbld', 11:12:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:37 INFO - 'MOZ_NO_REMOTE': '1', 11:12:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:37 INFO - 'NO_EM_RESTART': '1', 11:12:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:12:37 INFO - 'PWD': '/builds/slave/test-pgo', 11:12:37 INFO - 'SHELL': '/bin/bash', 11:12:37 INFO - 'SHLVL': '1', 11:12:37 INFO - 'TERM': 'linux', 11:12:37 INFO - 'TMOUT': '86400', 11:12:37 INFO - 'USER': 'cltbld', 11:12:37 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1450376188.393086-729757505', 11:12:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:37 INFO - '_': '/tools/buildbot/bin/python'} 11:12:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:12:37 INFO - Running setup.py (path:/tmp/pip-GkE2dS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:12:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:12:38 INFO - Running setup.py (path:/tmp/pip-ZjcfJh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:12:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:12:38 INFO - Running setup.py (path:/tmp/pip-YkFMGR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:12:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:12:38 INFO - Running setup.py (path:/tmp/pip-IQzK_W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:12:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 11:12:38 INFO - Running setup.py (path:/tmp/pip-Cygsgc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 11:12:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:12:38 INFO - Running setup.py (path:/tmp/pip-GDjo7O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:12:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:12:38 INFO - Running setup.py (path:/tmp/pip-M8eET9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:12:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:12:38 INFO - Running setup.py (path:/tmp/pip-S_Pcqf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:12:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 11:12:38 INFO - Running setup.py (path:/tmp/pip-Ax50kk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 11:12:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 11:12:38 INFO - Running setup.py (path:/tmp/pip-2veO_H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 11:12:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:12:38 INFO - Running setup.py (path:/tmp/pip-jIpYWb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:12:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:12:38 INFO - Running setup.py (path:/tmp/pip-HCSKKI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:12:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:12:38 INFO - Running setup.py (path:/tmp/pip-4rxoCP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:12:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:12:38 INFO - Running setup.py (path:/tmp/pip-ELmsYX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:12:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:12:39 INFO - Running setup.py (path:/tmp/pip-dfJtTn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:12:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 11:12:39 INFO - Running setup.py (path:/tmp/pip-ezFovb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 11:12:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 11:12:39 INFO - Running setup.py (path:/tmp/pip-Qr0nvB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 11:12:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:12:39 INFO - Running setup.py install for manifestparser 11:12:39 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 11:12:39 INFO - Running setup.py install for mozcrash 11:12:39 INFO - Running setup.py install for mozdebug 11:12:39 INFO - Running setup.py install for mozdevice 11:12:39 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 11:12:39 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 11:12:39 INFO - Running setup.py install for mozfile 11:12:39 INFO - Running setup.py install for mozhttpd 11:12:39 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 11:12:39 INFO - Running setup.py install for mozinfo 11:12:39 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 11:12:39 INFO - Running setup.py install for mozInstall 11:12:40 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 11:12:40 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 11:12:40 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 11:12:40 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 11:12:40 INFO - Running setup.py install for mozleak 11:12:40 INFO - Running setup.py install for mozlog 11:12:40 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 11:12:40 INFO - Running setup.py install for moznetwork 11:12:40 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 11:12:40 INFO - Running setup.py install for mozprocess 11:12:40 INFO - Running setup.py install for mozprofile 11:12:40 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 11:12:40 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 11:12:40 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 11:12:40 INFO - Running setup.py install for mozrunner 11:12:40 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 11:12:40 INFO - Running setup.py install for mozscreenshot 11:12:40 INFO - Running setup.py install for moztest 11:12:40 INFO - Running setup.py install for mozversion 11:12:40 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 11:12:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:12:40 INFO - Cleaning up... 11:12:40 INFO - Return code: 0 11:12:40 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:12:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:40 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 0x7fa23b612f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c5600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1754350>, '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 0x1755250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17556e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1450376188.393086-729757505', '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 11:12:40 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 11:12:40 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 11:12:40 INFO - Using env: {'DISPLAY': ':0', 11:12:40 INFO - 'HOME': '/home/cltbld', 11:12:40 INFO - 'LANG': 'en_US.UTF-8', 11:12:40 INFO - 'LANGUAGE': 'en_US:en', 11:12:40 INFO - 'LOGNAME': 'cltbld', 11:12:40 INFO - 'MAIL': '/var/mail/cltbld', 11:12:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:40 INFO - 'MOZ_NO_REMOTE': '1', 11:12:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:40 INFO - 'NO_EM_RESTART': '1', 11:12:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:12:40 INFO - 'PWD': '/builds/slave/test-pgo', 11:12:40 INFO - 'SHELL': '/bin/bash', 11:12:40 INFO - 'SHLVL': '1', 11:12:40 INFO - 'TERM': 'linux', 11:12:40 INFO - 'TMOUT': '86400', 11:12:40 INFO - 'USER': 'cltbld', 11:12:40 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1450376188.393086-729757505', 11:12:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:40 INFO - '_': '/tools/buildbot/bin/python'} 11:12:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:12:41 INFO - Running setup.py (path:/tmp/pip-7xB3_l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:12:41 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)) 11:12:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:12:41 INFO - Running setup.py (path:/tmp/pip-stWiQ8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:12:41 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)) 11:12:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:12:41 INFO - Running setup.py (path:/tmp/pip-rZxSNj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:12:41 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)) 11:12:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:12:41 INFO - Running setup.py (path:/tmp/pip-Bxu0Jm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:12:41 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)) 11:12:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 11:12:41 INFO - Running setup.py (path:/tmp/pip-CQqJpL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 11:12:41 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)) 11:12:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:12:41 INFO - Running setup.py (path:/tmp/pip-UJFEsK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:12:41 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)) 11:12:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:12:41 INFO - Running setup.py (path:/tmp/pip-g1zPGJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:12:41 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)) 11:12:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:12:41 INFO - Running setup.py (path:/tmp/pip-3cjI07-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:12:41 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)) 11:12:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 11:12:41 INFO - Running setup.py (path:/tmp/pip-ZJE20U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 11:12:41 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)) 11:12:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 11:12:41 INFO - Running setup.py (path:/tmp/pip-ssXJte-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 11:12:41 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)) 11:12:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:12:41 INFO - Running setup.py (path:/tmp/pip-6SWWww-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:12:41 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)) 11:12:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:12:41 INFO - Running setup.py (path:/tmp/pip-aAHFB6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:12:42 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)) 11:12:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:12:42 INFO - Running setup.py (path:/tmp/pip-I7u33E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:12:42 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)) 11:12:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:12:42 INFO - Running setup.py (path:/tmp/pip-Dp8BAG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:12:42 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)) 11:12:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:12:42 INFO - Running setup.py (path:/tmp/pip-GCuXtj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:12:42 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)) 11:12:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 11:12:42 INFO - Running setup.py (path:/tmp/pip-xoTODD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 11:12:42 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)) 11:12:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 11:12:42 INFO - Running setup.py (path:/tmp/pip-g5wnGY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 11:12:42 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)) 11:12:42 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)) 11:12:42 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)) 11:12:42 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)) 11:12:42 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)) 11:12:42 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)) 11:12:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 11:12:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:44 INFO - Downloading blessings-1.5.1.tar.gz 11:12:44 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 11:12:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 11:12:44 INFO - Installing collected packages: blessings 11:12:44 INFO - Running setup.py install for blessings 11:12:44 INFO - Successfully installed blessings 11:12:44 INFO - Cleaning up... 11:12:44 INFO - Return code: 0 11:12:44 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 11:12:44 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 11:12:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 11:12:44 INFO - Reading from file tmpfile_stdout 11:12:44 INFO - Current package versions: 11:12:44 INFO - argparse == 1.2.1 11:12:44 INFO - blessings == 1.5.1 11:12:44 INFO - blobuploader == 1.2.4 11:12:44 INFO - docopt == 0.6.1 11:12:44 INFO - manifestparser == 1.1 11:12:44 INFO - mozInstall == 1.12 11:12:44 INFO - mozcrash == 0.16 11:12:44 INFO - mozdebug == 0.1 11:12:44 INFO - mozdevice == 0.46 11:12:44 INFO - mozfile == 1.2 11:12:44 INFO - mozhttpd == 0.7 11:12:44 INFO - mozinfo == 0.8 11:12:44 INFO - mozleak == 0.1 11:12:44 INFO - mozlog == 3.0 11:12:44 INFO - moznetwork == 0.27 11:12:44 INFO - mozprocess == 0.22 11:12:44 INFO - mozprofile == 0.27 11:12:44 INFO - mozrunner == 6.11 11:12:44 INFO - mozscreenshot == 0.1 11:12:44 INFO - mozsystemmonitor == 0.0 11:12:44 INFO - moztest == 0.7 11:12:44 INFO - mozversion == 1.4 11:12:44 INFO - psutil == 3.1.1 11:12:44 INFO - requests == 1.2.3 11:12:44 INFO - wsgiref == 0.1.2 11:12:44 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:12:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:44 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7fa23b612f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c5600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1754350>, '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 0x1755250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17556e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1450376188.393086-729757505', '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 11:12:44 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 11:12:44 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 11:12:44 INFO - Using env: {'DISPLAY': ':0', 11:12:44 INFO - 'HOME': '/home/cltbld', 11:12:44 INFO - 'LANG': 'en_US.UTF-8', 11:12:44 INFO - 'LANGUAGE': 'en_US:en', 11:12:44 INFO - 'LOGNAME': 'cltbld', 11:12:44 INFO - 'MAIL': '/var/mail/cltbld', 11:12:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:44 INFO - 'MOZ_NO_REMOTE': '1', 11:12:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:44 INFO - 'NO_EM_RESTART': '1', 11:12:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:12:44 INFO - 'PWD': '/builds/slave/test-pgo', 11:12:44 INFO - 'SHELL': '/bin/bash', 11:12:44 INFO - 'SHLVL': '1', 11:12:44 INFO - 'TERM': 'linux', 11:12:44 INFO - 'TMOUT': '86400', 11:12:44 INFO - 'USER': 'cltbld', 11:12:44 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1450376188.393086-729757505', 11:12:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:44 INFO - '_': '/tools/buildbot/bin/python'} 11:12:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:44 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)) 11:12:44 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)) 11:12:44 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)) 11:12:44 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)) 11:12:44 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)) 11:12:44 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)) 11:12:44 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)) 11:12:44 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)) 11:12:44 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)) 11:12:44 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)) 11:12:44 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)) 11:12:44 INFO - Cleaning up... 11:12:44 INFO - Return code: 0 11:12:44 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 11:12:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:44 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa23b612f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c5600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1754350>, '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 0x1755250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17556e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1450376188.393086-729757505', '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 11:12:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 11:12:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:12:44 INFO - Using env: {'DISPLAY': ':0', 11:12:44 INFO - 'HOME': '/home/cltbld', 11:12:44 INFO - 'LANG': 'en_US.UTF-8', 11:12:44 INFO - 'LANGUAGE': 'en_US:en', 11:12:44 INFO - 'LOGNAME': 'cltbld', 11:12:44 INFO - 'MAIL': '/var/mail/cltbld', 11:12:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:44 INFO - 'MOZ_NO_REMOTE': '1', 11:12:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:44 INFO - 'NO_EM_RESTART': '1', 11:12:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:12:44 INFO - 'PWD': '/builds/slave/test-pgo', 11:12:44 INFO - 'SHELL': '/bin/bash', 11:12:44 INFO - 'SHLVL': '1', 11:12:44 INFO - 'TERM': 'linux', 11:12:44 INFO - 'TMOUT': '86400', 11:12:44 INFO - 'USER': 'cltbld', 11:12:44 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1450376188.393086-729757505', 11:12:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:44 INFO - '_': '/tools/buildbot/bin/python'} 11:12:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:45 INFO - Downloading/unpacking jsonschema 11:12:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:12:46 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 11:12:46 INFO - Downloading/unpacking functools32 (from jsonschema) 11:12:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:46 INFO - Downloading functools32-3.2.3-2.tar.gz 11:12:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 11:12:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 11:12:46 INFO - warning: no files found matching '*.txt' 11:12:46 INFO - no previously-included directories found matching 'build' 11:12:46 INFO - no previously-included directories found matching 'dist' 11:12:46 INFO - no previously-included directories found matching '.git*' 11:12:46 INFO - Installing collected packages: jsonschema, functools32 11:12:46 INFO - Running setup.py install for functools32 11:12:47 INFO - warning: no files found matching '*.txt' 11:12:47 INFO - no previously-included directories found matching 'build' 11:12:47 INFO - no previously-included directories found matching 'dist' 11:12:47 INFO - no previously-included directories found matching '.git*' 11:12:47 INFO - Successfully installed jsonschema functools32 11:12:47 INFO - Cleaning up... 11:12:47 INFO - Return code: 0 11:12:47 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 11:12:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:47 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa23b612f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c5600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1754350>, '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 0x1755250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17556e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1450376188.393086-729757505', '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 11:12:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 11:12:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 11:12:47 INFO - Using env: {'DISPLAY': ':0', 11:12:47 INFO - 'HOME': '/home/cltbld', 11:12:47 INFO - 'LANG': 'en_US.UTF-8', 11:12:47 INFO - 'LANGUAGE': 'en_US:en', 11:12:47 INFO - 'LOGNAME': 'cltbld', 11:12:47 INFO - 'MAIL': '/var/mail/cltbld', 11:12:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:47 INFO - 'MOZ_NO_REMOTE': '1', 11:12:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:47 INFO - 'NO_EM_RESTART': '1', 11:12:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:12:47 INFO - 'PWD': '/builds/slave/test-pgo', 11:12:47 INFO - 'SHELL': '/bin/bash', 11:12:47 INFO - 'SHLVL': '1', 11:12:47 INFO - 'TERM': 'linux', 11:12:47 INFO - 'TMOUT': '86400', 11:12:47 INFO - 'USER': 'cltbld', 11:12:47 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1450376188.393086-729757505', 11:12:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:47 INFO - '_': '/tools/buildbot/bin/python'} 11:12:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:47 INFO - Downloading/unpacking flake8 11:12:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:49 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:12:49 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 11:12:49 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:12:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:49 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:12:49 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 11:12:49 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:12:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:49 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 11:12:49 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:12:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 11:12:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 11:12:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:12:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:12:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:12:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:12:49 INFO - no previously-included directories found matching 'docs/_build' 11:12:49 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:12:49 INFO - Running setup.py install for pep8 11:12:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:12:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:12:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:12:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:12:49 INFO - no previously-included directories found matching 'docs/_build' 11:12:49 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 11:12:49 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:12:49 INFO - Cleaning up... 11:12:49 INFO - Return code: 0 11:12:49 INFO - Running post-action listener: _resource_record_post_action 11:12:49 INFO - Running post-action listener: _start_resource_monitoring 11:12:49 INFO - Starting resource monitoring. 11:12:49 INFO - ##### 11:12:49 INFO - ##### Running install step. 11:12:49 INFO - ##### 11:12:49 INFO - Running pre-action listener: _resource_record_pre_action 11:12:49 INFO - Running main action method: install 11:12:49 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 11:12:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 11:12:50 INFO - Reading from file tmpfile_stdout 11:12:50 INFO - Detecting whether we're running mozinstall >=1.0... 11:12:50 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 11:12:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 11:12:50 INFO - Reading from file tmpfile_stdout 11:12:50 INFO - Output received: 11:12:50 INFO - Usage: mozinstall [options] installer 11:12:50 INFO - Options: 11:12:50 INFO - -h, --help show this help message and exit 11:12:50 INFO - -d DEST, --destination=DEST 11:12:50 INFO - Directory to install application into. [default: 11:12:50 INFO - "/builds/slave/test-pgo"] 11:12:50 INFO - --app=APP Application being installed. [default: firefox] 11:12:50 INFO - mkdir: /builds/slave/test-pgo/build/application 11:12:50 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'] 11:12:50 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 11:13:04 INFO - Reading from file tmpfile_stdout 11:13:04 INFO - Output received: 11:13:04 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 11:13:04 INFO - Running post-action listener: _resource_record_post_action 11:13:04 INFO - ##### 11:13:04 INFO - ##### Running run-tests step. 11:13:04 INFO - ##### 11:13:04 INFO - Running pre-action listener: _resource_record_pre_action 11:13:04 INFO - Running main action method: run_tests 11:13:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 11:13:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 11:13:04 INFO - Python 2.7.3 11:13:04 INFO - Return code: 0 11:13:04 INFO - grabbing minidump binary from tooltool 11:13: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')]} 11:13:04 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 0x1754350>, '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 0x1755250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17556e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 11:13:04 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 11:13:04 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 11:13:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:13:04 INFO - Return code: 0 11:13:04 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 11:13:04 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 11:13:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 11:13:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 11:13:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 11:13:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 11:13:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 11:13:05 INFO - Return code: 0 11:13:05 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/1450371150/firefox-44.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 11:13:05 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/1450371150/firefox-44.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --webServer localhost 11:13:05 INFO - Using env: {'DISPLAY': ':0', 11:13:05 INFO - 'HOME': '/home/cltbld', 11:13:05 INFO - 'LANG': 'en_US.UTF-8', 11:13:05 INFO - 'LANGUAGE': 'en_US:en', 11:13:05 INFO - 'LOGNAME': 'cltbld', 11:13:05 INFO - 'MAIL': '/var/mail/cltbld', 11:13:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 11:13:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 11:13:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:05 INFO - 'MOZ_NO_REMOTE': '1', 11:13:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 11:13:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:05 INFO - 'NO_EM_RESTART': '1', 11:13:05 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:13:05 INFO - 'PWD': '/builds/slave/test-pgo', 11:13:05 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 11:13:05 INFO - 'SHELL': '/bin/bash', 11:13:05 INFO - 'SHLVL': '1', 11:13:05 INFO - 'TERM': 'linux', 11:13:05 INFO - 'TMOUT': '86400', 11:13:05 INFO - 'USER': 'cltbld', 11:13:05 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1450376188.393086-729757505', 11:13:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:05 INFO - '_': '/tools/buildbot/bin/python'} 11:13:05 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/1450371150/firefox-44.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost'] with output_timeout 3600 11:13:05 INFO - mozversion INFO | application_buildid: 20151217085230 11:13:05 INFO - mozversion INFO | application_changeset: ad87069605122c4c951874216bd941bea00c6c04 11:13:05 INFO - mozversion INFO | application_display_name: Nightly 11:13:05 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:13:05 INFO - mozversion INFO | application_name: Firefox 11:13:05 INFO - mozversion INFO | application_remotingname: firefox 11:13:05 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-beta 11:13:05 INFO - mozversion INFO | application_vendor: Mozilla 11:13:05 INFO - mozversion INFO | application_version: 44.0 11:13:05 INFO - mozversion INFO | platform_buildid: 20151217085230 11:13:05 INFO - mozversion INFO | platform_changeset: ad87069605122c4c951874216bd941bea00c6c04 11:13:05 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-beta 11:13:05 INFO - mozversion INFO | platform_version: 44.0 11:13:05 INFO - 2015-12-17 11:13:05,640 DEBUG : using testdate: 1450379585 11:13:05 INFO - 2015-12-17 11:13:05,640 DEBUG : actual date: 1450379585 11:13:05 INFO - 2015-12-17 11:13:05,648 INFO : starting webserver on 'localhost:51769' 11:13:05 INFO - 2015-12-17 11:13:05,649 INFO : Starting test suite talos-linux64-ix-023 11:13:05 INFO - 2015-12-17 11:13:05,650 INFO : Starting test dromaeo_css 11:13:05 INFO - 2015-12-17 11:13:05,650 DEBUG : operating with platform_type : linux_ 11:13:05 INFO - 2015-12-17 11:13:05,650 INFO : Initialising browser for dromaeo_css test... 11:13:05 INFO - 2015-12-17 11:13:05,667 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp0y9HpF/profile http://localhost:51769/getInfo.html 11:13:09 INFO - 2015-12-17 11:13:09,304 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:13:09 INFO - 2015-12-17 11:13:09,304 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:13:09 INFO - 2015-12-17 11:13:09,304 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:13:09 INFO - 2015-12-17 11:13:09,305 DEBUG : BROWSER_OUTPUT: __metrics 11:13:09 INFO - 2015-12-17 11:13:09,446 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] 11:13:10 INFO - 2015-12-17 11:13:10,689 INFO : Browser initialized. 11:13:10 INFO - 2015-12-17 11:13:10,690 INFO : Running cycle 1/1 for dromaeo_css test... 11:13:10 INFO - 2015-12-17 11:13:10,690 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp0y9HpF/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:13:22 INFO - 2015-12-17 11:13:22,159 DEBUG : BROWSER_OUTPUT: RSS: Main: 128462848 11:13:22 INFO - 2015-12-17 11:13:22,160 DEBUG : BROWSER_OUTPUT: 11:14:13 INFO - 2015-12-17 11:14:13,004 DEBUG : BROWSER_OUTPUT: 1450379653004 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] 11:16:21 INFO - 2015-12-17 11:16:21,250 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51769/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51769/tests/dromaeo/cssquery-ext.html) 11:16:22 INFO - 2015-12-17 11:16:22,326 DEBUG : BROWSER_OUTPUT: RSS: Main: 236785664 11:16:22 INFO - 2015-12-17 11:16:22,326 DEBUG : BROWSER_OUTPUT: 11:19:24 INFO - 2015-12-17 11:19:24,373 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51769/tests/dromaeo/cssquery-ext.html (next: http://localhost:51769/tests/dromaeo/cssquery-jquery.html) 11:19:24 INFO - 2015-12-17 11:19:24,939 DEBUG : BROWSER_OUTPUT: RSS: Main: 208142336 11:19:24 INFO - 2015-12-17 11:19:24,939 DEBUG : BROWSER_OUTPUT: 11:22:26 INFO - 2015-12-17 11:22:26,598 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51769/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51769/tests/dromaeo/cssquery-mootools.html) 11:22:27 INFO - 2015-12-17 11:22:27,159 DEBUG : BROWSER_OUTPUT: RSS: Main: 206069760 11:22:27 INFO - 2015-12-17 11:22:27,160 DEBUG : BROWSER_OUTPUT: 11:25:28 INFO - 2015-12-17 11:25:28,904 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51769/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51769/tests/dromaeo/cssquery-prototype.html) 11:25:29 INFO - 2015-12-17 11:25:29,470 DEBUG : BROWSER_OUTPUT: RSS: Main: 190410752 11:25:29 INFO - 2015-12-17 11:25:29,470 DEBUG : BROWSER_OUTPUT: 11:28:31 INFO - 2015-12-17 11:28:31,886 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51769/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51769/tests/dromaeo/cssquery-yui.html) 11:28:32 INFO - 2015-12-17 11:28:32,449 DEBUG : BROWSER_OUTPUT: RSS: Main: 192815104 11:28:32 INFO - 2015-12-17 11:28:32,449 DEBUG : BROWSER_OUTPUT: 11:31:34 INFO - 2015-12-17 11:31:34,505 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51769/tests/dromaeo/cssquery-yui.html (next: http://localhost:51769/tests/dromaeo/cssquery-dojo.html) 11:31:34 INFO - 2015-12-17 11:31:34,756 DEBUG : BROWSER_OUTPUT: RSS: Main: 235741184 11:31:34 INFO - 2015-12-17 11:31:34,756 DEBUG : BROWSER_OUTPUT: 11:31:34 INFO - 2015-12-17 11:31:34,756 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:31:34 INFO - 2015-12-17 11:31:34,756 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:31:34 INFO - 2015-12-17 11:31:34,756 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:31:34 INFO - 2015-12-17 11:31:34,756 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:31:34 INFO - 2015-12-17 11:31:34,760 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3399.3031428557147;3412.692857642813;3426.7087297579706;3441.604215515215;3473.947890781638;5706.3722990471015;5713.571482138841;5746.425357464252;5751.971240143798;5759.020966435705;5706.65760054397;5711.914321285174;5752.5110365618975;5756.194132821408;5758.193852860592;5117.590592752589;5234.293370394986;5247.370315562138;5308.389535203443;5329.973350133244;5222.399424066243;5222.529972302492;5232.29364035856;5256.737163141846;5320.122179840322;5331.120365139747;5349.5720342372515;5364.865878353053;5366.973165134169;5370.301860758096;5277.894442111175;5280.630355875091;5339.038972984861;5351.277577527062;5375.784968601251;5078.7968481260705;5105.489451054865;5152.819651312186;5158.148905430637;5175.171972484384;5488.451154884519;5489.204065410533;5492.862678433031;5511.889762204773;5516.641418307797;5815.941840581582;6127.969360153215;6145.877082458371;6147.846303842395;6164.753409863645;6009.308929473123;6124.846878828021;6246.687665616746;6249.218847644044;6267.091271765614;5795.246617939683;5809.88380232393;5810;5812.070068788974;5846.736896839652;6020.518358531307;6118.714631166882;6290.21372328459;6317.736452709477;6322.652254126067;6022.909656355158;6101.8474538136015;6111.188574387999;6112.505978000999;6117.234543797379;6186.443220110212;6218.440340369298;6220.688965551704;6231.283402408691;6242.531810114259;5938.524918006549;6078.149059131725;6088.939110608837;6178.814635560941;6188.412100850412;6103.511719062553;6104.481119104926;6105.725242364104;6106.45041946227;6129.662868542184;4722.905541889212;4725.362076119749;4731.716097034189;4737.431508219036;4759.50025247351;4115.403266526337;4160.271952408377;4203.264428725022;4214.536400995888;4235.915281694349;5679.659220446786;5684;5688.317401911714;5688.516476099578;5760.51035661965;6180.752769889244;6184.288806787277;6185.288691800411;6191.876162476725;6193.473554747807;5567.2762540870235;5673.744681489343;5685.1756495307945;5771;5771.249737534094;5348.358197016383;5354.705491198021;5389.649672771257;5391.406945236021;5392.0294347017125;6072.36240194782;6387.073874288295;6396.488280937514;6399.200099987502;6400.903986440114;6071.423214794588;6125.601835880653;6159.353267906985;6160.229971253593;6178.320384757583;6363.61818290904;6456.451201647913;6471.546991710723;6476.579022363531;6476.870462590816;5909.5863289569315;6033.3061697905305;6157.107219453064;6197.194364732556;6200.441960223421;6047.485963693135;6151.876962460815;6155.199824022849;6159.84600384994;6162.22972128484;6039.245094363205;6118.571699980958;6120.112583675431;6120.571559990758;6121.663308518075;5802.361740208658;5924.733386997682;5984.551158663205;6060.303065147565;6099.725512351866;5971.402859713994;5982.970085149721;5990.7903223386975;5992.161097446274;6004.039353703386;6042.305134909541;6081.239845019372;6094.725737341919;6101;6107.511399088151;5721.628094173865;5775.989201889569;5832.504237139721;5914.083317085859;5949.8215053548465 11:31:34 INFO - 2015-12-17 11:31:34,760 DEBUG : BROWSER_OUTPUT: |1;ext.html;602.936691647377;635.6853357587995;637.0189907542385;672.1732269308748;679.2765704524684;40783.38824917625;41095;41109.79445102774;41222;41316.79341603295;45018;45590.772046139726;45604;45627.31559026609;45637.31544026834;8040.316573091294;8177.836443271131;9186.173244408019;9360.859587106199;10633.149348052177;10868.45657717115;10879;10914.617988370408;10926.726831829188;10968.670939871778;11033.558657653684;11135.220534562584;11137.276077055007;11139.888601113966;11149.331040137618;10950.233483656148;11033.668989930315;11034.448277586169;11047.226694131374;11049.889501104966;10921.617743379024;10928.180386471047;11009.504572294267;11030.448477576088;11051.17116216279;44416.55583444189;44816.10367792626;44845.551544484464;44883.551164488264;44919.55080449186;3717.646823551758;3767.698584113264;3793.905152371185;3804.087019115392;3827.827747751358;31787.523187152212;31876.681233187603;34309.485357719655;34586.30827383438;34949.301013979835;3388.6611338866164;3406.0463070340097;3445.3970555152746;3488.720902327808;3563.9109022274392;303878;310946.44526777446;312146;313274;313408;61874.381256187764;63320.68339658364;72344.63827680828;72740.63629681818;73119;80291.59854200692;81060.59469702732;81313;81374;81386.59306703428;17626.823731762775;17654.646907061786;17757.378491752726;17804.020778857288;17849.929004259786;14754.114753114847;14945.551633451014;14955.177465239516;14965.326560304813;14967.326470308644;24510.264692059267;24799.13203037885;24891;24906.5018699625;25020.124295649566;9340.299477539213;9486.430814151174;9549.137918105902;9693;9835.164011058998;997.984072174204;1145.8999360613905;1155.9017483513828;1181.8168183931505;1202.3927916402336;30711.69288307133;31415;31582.210444738605;35411;35746;1103.1175059952006;1209.407390378708;1246.0003389120843;1250.662321173278;1255.1841303153024;14669.413223470941;15818.841811581968;15877.967932084377;16138.35446582147;17260.482185534453;415071;420064;420656;420944;422344;60996.39003609996;61617.38382616206;61622.69188654028;61645;61673.07490387648;1426.450816435659;1479.0312345413772;1531.379791184572;1561.375449820081;1598.3926108078856;31637.050888473383;31692.5246121313;32295.51556726604;34118.658813411545;35405.645943540236;57308.71345643245;57920.420795791506;58015.41984580269;58073.70963145157;58087.12869306879;349091;354770;354983;355070;356473;47652.285215722484;48015;48574.27138592995;48948.75525622349;49023.50976490189;51943.480565193866;52106.478935210165;52524;52731.73634131805;53561;42697.573024270605;43581.78209109061;43726.78136609297;44554.3316850254;45025;46782;47078.52921470878;48561.757191213816;48895.26657100075;49280.75359623179;42052.57947420487;42302.576974231095;47026.52973470358;47752.28371574359;47771.761141194074;35434.82282588674;36023.541809577946;36716.44925326069;37345.626543734215;37488.43767343547;27967.860160699067;28623.713762862106;28656.14031579056;28873.422531548833;28987.7101228985 11:31:34 INFO - 2015-12-17 11:31:34,763 DEBUG : BROWSER_OUTPUT: |2;jquery.html;384.455321931789;388.49883650091385;390.2390338839264;390.97263191576593;394.4083874188717;13614.727705445885;14161.575152745434;18232.361867334646;20665.99999999998;20698.586028279424;13073.803892941614;13386.799198012037;13402.128861624013;19003.714944275813;20714.378568642966;4721.527847215269;4817.879553011186;4832.033593281358;4833.081714474256;4837.4195096588455;4807.639427042968;4849.733264670442;4850.2724591311235;4852.708837469745;4854;3826.349520581508;4428.734275943438;4810.326554282403;4814.590759785422;4816.518348165173;5126.615503837227;5154.278401023878;5169.405518365398;5177.508136727005;5191.714455704935;4461.174682683682;4560.338750881137;4564.977175114103;4574.794134263966;4577.519360467137;15340.616484587863;15749.370025198978;15765.763513547307;15788.526344209693;15835.76246356294;2207.823374130082;2262.8076613487874;2297;2338.181636427254;2375.786179243876;10501.789964200749;11014;11050.226484146113;11146.777064458747;11274.210805243554;1785.1074462768615;1807.8915265084006;1855.5546668799525;1871.9719204211947;1899.7150427435995;66664.33335666629;67063.32936670669;68013.65993170052;68384.3161568383;68675;7624.5425274483705;7751.844963100706;7893.526388416713;7945.324647405036;7955.24425179607;9524.666636667684;9529.761755956019;9545.952270238744;9573.760655983517;9585.041495850359;6265.122882796412;6311.652859092702;6316.2736285326855;6317.273513546001;6423.518236132309;6602.3397660233595;6713.731450741916;6722.932770672329;6733.629650369178;6734.124563806674;3640.3265395901844;3657.835397407123;3666.6883314917995;3694.704423646102;3697.279030589063;1261.4386597964;1286.691194113406;1287.2984223598162;1290.1291628150962;1319.736052789446;417.997910010448;526.6734624532737;534.943830897758;539.2046731071716;551;13032.674183145307;13329.133606315558;13502.054856159975;13530.45878164882;13591.932040339734;528.516407487145;531.0441205829492;539.6303532080537;554.5979165105266;597.6175247841385;6599.868002639921;7306.159791624032;7347.155077166088;7414.369778568882;7464.70141194357;664663;681517;685139;693095;701156;67039.31283779342;74792.25207747961;87654.56172719096;88627.55686221656;89335.55332223428;596.7672607683007;609.3571282297219;610.1793088296234;610.7418717442083;612.2071916867578;11728.94135529317;11968.76062478728;12200.572979946015;12288.81566776517;12321.383930803604;38772.80613596914;38919.44322227079;39184;39806;40128.398074029494;48554.27168592544;50761;50986.490135098175;53006;53522.73238633782;7431.182569917413;7588.392928565812;7594.848103037798;7655.923440765521;7674.961625191839;6307.590006649553;13531.458741650224;13824.820291332848;13890.930545347208;14127.081739686888;9636.75908102303;11910.702232444259;11952.64142075739;11959.521619135485;11994.460249288977;11051.392173430539;11256.606018789304;11660.591879284184;11695;12005.279683219034;11591.826122608;11841.644750657493;11891.940540297242;11959.402029898645;11959.521619135137;7430.665620047002;7483.738069167553;7502;7508.887366689395;7525.548467091992;11684;11860.525578976743;11963.64109076729;12316.50733970667;12320.383980800745 11:31:34 INFO - 2015-12-17 11:31:34,765 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1563.765435184722;1569.5448319987197;1787.195761907142;1846.639905218482;1860.3116846766698;7199.568025918448;7298.197198308182;8126.553039582821;8338.249557539828;8344.666213351466;7993.680252789896;8027.197280271985;8137.30832879206;8139.511629302246;8155.225253600914;2350.4123969007705;2419.0565679385054;2424.490856920049;2425.575524283252;2426.3691440225493;2174.423777698911;2206.2388475975763;2465.5315490056923;2469.1604854349516;2492.4890397468566;2426.514697060586;2427.320350301918;2429.878506074698;2452.460458699083;2455.6439316299125;2427.4416884116663;2437.305367970138;2452.840565363246;2455.938601534967;2457.2751038443703;2430.2466235466886;2471.023945541519;2472.851628902272;2475.2450502596703;2475.7276699563035;8192.713255036046;8224.547649879254;8244.051934027604;8248.83502329956;8295.460795048302;5057.519535644108;5108.386993560759;5118.948810511884;5125.974370128163;5133.922991155136;3338.565986421774;3341.198112453018;3472.531208286874;3495.07380544156;3505.1762835733584;1115.5036008976008;1132.116948779953;1143.8798926112722;1146.7649131927935;1199.5801469485698;11407.25852819564;11527.538898444052;11558.942205289004;11560.826587601192;11562.479688414041;4616.16908956391;4649;4653.581177694024;4680.46174689915;4682.765861706901;9908.20734341251;9933.900660993442;9936.900630993598;9943.154831839374;9944.45305508204;5163.302954101224;5168.767405466763;5172.5603323717905;5176.896462070813;5178.741062946838;4692.788824502905;4692.906141877143;4697.741624210701;4698.36572062774;4703.6942598730975;3529.770564913272;3921.11774850662;3934.370500719871;3983.143624120828;3985.900352491211;1237.3503910446907;1273.0515765754571;1275.6491964709778;1279.36031984008;1295.9740805183844;1134.7276653603076;1396.197186617699;1449.0219102106037;1458.2635768936832;1485.2054151029147;7957.283844454027;7984.720534781255;8010.599470026592;8059.677612895536;8067;1157.7742340243572;1164.185070450671;1171.4855433698904;1251.4305990774176;1252.8935040521658;6248.062790581358;6267.091271765568;6300.30696623371;6308.621482711052;6311.936880631227;10007.199424046059;10103.949480252699;10162.949185254027;10178;10183.18534517237;9829.754256143653;10017.649382271586;10048.447335396477;10063.04401081896;10075.3954762713;7783.922160778433;7846.136924938366;7849.293563579306;7858.764237072897;7861.52830830152;7629.923700762922;7706.730264440942;7712.807179820549;7726.42051846125;7740.41946853977;8534.445261058012;8959.641614335615;8977.551122443982;9014.549272536478;9120.908790912272;8930.955345223232;9013.639454422011;9104.772380690536;9346.906530934604;9348.20540254086;8031.437799353989;8090.231428014329;8163;8167.264946154874;8169.673213071411;7259.165196002527;7335.706571737284;8121.553314567519;8173.305269052197;8185.672573097009;7641.7707468776025;7650.387968962581;7703.114141873756;7817.413693972861;7834.0599128105;7472.551646901204;7638.656260468403;7642.350400216044;7760.45676802641;7785.493942893921;7693.115291741297;7716.228377162239;7730.536167829948;7879.212078792075;7890.408219383455;7226.313500217471;7267.091613548307;7312.634368281671;7313.451491138292;7315.926840731525;7076.787696369117;7126.608036557832;7132.215456299907;7311.780646580611;7322.3775979042375 11:31:34 INFO - 2015-12-17 11:31:34,766 DEBUG : BROWSER_OUTPUT: |4;prototype.html;343.5962743776063;354.70736642270134;363.38587786640574;364.6608653951827;369.0717844620779;5861.267341582302;5956.106584012389;6004.819855404339;6008.909866352003;6017.939820601792;5779.133130030497;5897.380775018625;5909.349971503142;5909.85225369366;5917.704114794265;4622.653301002439;4632.351470794091;4640.327152562885;4643.187442197619;4643.837465688702;4428.357888106223;4491.191585514606;4558.680892337537;4633.142868569325;4643.721376717391;4578.969731810349;4592.15045216636;4598.816047358102;4602.700824446417;4604.562566556172;4585.037142200142;4592.6555508337005;4593.173228818828;4593.862184134481;4604.056168485453;4050.797460126982;4052.858149964737;4057.898552536181;4058.0463591056077;4064.4309796628495;5575.418106701594;5654.9151762723595;5687.601867869251;5724.9427505724825;5726.226959360475;5395.865103372447;5400.324959380077;5407.810726624549;5411.431799661018;5413.485718856702;6037.849053773647;6349.111124442582;6357.014662727284;6357.809265722036;6359.20509936258;4362.629176519999;4465.68740188187;4516.796744146522;4522.253828118356;4532.592066713979;6457.80626581208;6461.160049193575;6470.708818103197;6491.578047426902;6497.447716944065;4626.329182268552;4627.467841198305;4628.791704373311;4629.768511574475;4630;4528.071745292207;4594.851287178206;4634.97682511592;4691.132140554008;4695.201815691341;5268.552173065333;5291.232771248225;5291.550218231417;5292.047431462297;5292.788288468418;6289.40250676185;6296.370362963758;6309.1167236586;6327.96836015817;6331.873362532723;1644.8519633232827;1656.3540219314477;1657.1382880901863;1657.709900767385;1658.6268089679968;1104.2601457023814;1115.16919894679;1120.3781901045;1127.3236058364917;1141.6175581180398;6090.33006369299;6113;6125.264968203844;6125.908111378333;6131.693415329305;6469.256035555877;6474.287828338879;6526.184226971629;6528.608283503005;6536.8365790855605;5985.34161242263;6093.695315234309;6103.023516237381;6104.236970378703;6108;3595.442706380515;3624.8006359649944;3627.165751877083;3627.3108109459645;3628.6552777486095;6735.326467353226;6745.494087943423;6745.966270168716;6746.494012949049;6747.730090796412;6629.46964242869;6711.127553418024;6719.395254427027;6729.6971636276485;6729.764458243938;6723.260441351447;6752.155980502437;6758.83102922421;6763.526553141233;6766.086578311963;6318.62088274705;6411.230652321751;6441.066045423481;6532.542722009413;6538.705758240986;6430.3891130342545;6445.162128923397;6466.741330346922;6474.773382931575;6476.352364763675;6669.866602667822;6689.130413046273;6702.229243637044;6704.631245281556;6711.664416779044;4472.105578884171;4582.19811532987;4582.335561343653;4587.839425620087;4611.123886461562;6516.837079072871;6630.204375474974;6634.701438435379;6642.90035649456;6646.501512386687;6443.259025212161;6451.48388128958;6453.9354606453335;6455.9677201613695;6466.224053113657;6343.143675603735;6456.7740129095255;6461.06314584392;6462.870742585028;6467.191601049869;6310.337414571588;6313.337099604475;6314.494840412848;6317.684115794284;6359.141515895295;6453.870922581616;6456.935430645822;6458.773942912164;6464;6485.027245912962;6156.5998210116195;6262.812115636538;6285.308616052139;6302.243730752339;6324.114623952558 11:31:34 INFO - 2015-12-17 11:31:34,766 DEBUG : BROWSER_OUTPUT: |5;yui.html;896.0367604824813;897.4077109107988;934.0705997532456;934.2852717670978;972.2222222222225;15256.160911149882;16500.917495412537;16506.17469126542;16507.75238371424;16515.33938642453;15142.394304227817;15196.240187990585;15214.163221022867;15222.391104355813;15236.466723664675;790.6876783670447;793.9801504962364;921.9585118669676;933.3793027636614;955.3360414511917;926.7266156483853;929.0894922975488;934.9392289501195;935.9812803743921;936.4240991790068;810.8580998325299;992.8113658404916;1008;1009.167436864586;1010.090918173646;813.446856137826;959.8128364968799;977.296346630425;978.4618459847092;979.0160888307277;721.700494294867;724.782565230434;725.5356571794056;726.6766289001397;727.8798998165296;13480;13538;13541.864581354257;13554.59336219915;13574.049816512848;13821.378037988316;13848.653783655389;13957.162570245819;13974.58076257714;14153.080049796834;10179.949100254526;10511.369317840954;10531.578736850517;10532.42071686057;10648.467576621215;3509.596396414394;3548.0420286522494;3554.644535546425;3555.6088830228655;3559.75081744278;53860.46139538594;53907.46092539064;54003.72998134984;54263;55608;8179.795505112301;8224.259816616533;8244.134365891496;8283.544405057659;11012.284201526874;14313.928430357782;14421.855781442051;14447.422103115758;14458.638534036732;14470.059446135967;7676.19399963007;7830.569318687527;7832.334251588565;7846.803829904298;7914.287714105758;4484.349769283435;4565.771711414416;4575.748333841604;4588.908221835544;4602.332661764092;3174.761892858045;3185.155933677577;3196.744260459158;3199.2481766784786;3202.439573074703;473.5808809203879;479.92321228603254;481.4727872979082;485.7110019538369;498.3894728957071;706.3925024478943;712.9911772320798;720.8486217894301;738.471992525347;747.8952946587482;9208.26333893287;9489;9513.286503512265;9584.472853993097;9627.229821614254;571.8893621652654;662.718344703499;667.2126890269432;676.7800464848943;769.5190505933791;4656.511066338054;4755.001449695534;4773.832915847998;4818.253170758538;4819.180739274332;66576.33423665701;66686.33313666898;66719;66874.33125668681;66993.66503167454;54448.72775636175;55256.72371638116;55341.44658553443;55749.72125139349;56435;53861.46138538643;54150.18774718382;55147.44852551423;55492.44507554873;55918.440815592134;9358.672446464341;9381;9389.953050234704;9622.759431014281;9709.757256068655;40932.795336023126;41169.79415103025;41218.79390603028;42001.159976800904;42042;49419.50580494149;53834.730826347186;53847.46152538424;54307.18539221836;54466.45533544614;8453.704120355758;8586;9088.318376121684;9120.851783670987;9123;13088.869111308764;13146.935164846132;13361.933190333986;13378.13042152257;13644.044916856123;12750.42623081945;12811.679708007374;12818.230906145662;12986.545470908473;13222.669433264246;11631.6510504685;11637.359945202756;11696.239744416585;11750.70623234426;12032.217905836093;12586.370681466073;12617.558385456465;12703.491860325483;13041.804372934224;13296.468141274241;10190.286679932333;10771.784564308826;10797.73005674833;10890.782184356427;11393.462180863795;10303.896961030294;10343.741406464898;10344.586216551254;10371.94814025925;10463.633772817915 11:31:34 INFO - 2015-12-17 11:31:34,766 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:31:34 INFO - 2015-12-17 11:31:34,766 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:31:34 INFO - 2015-12-17 11:31:34,767 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,821 11:31:34 INFO - 2015-12-17 11:31:34,767 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:31:34 INFO - 2015-12-17 11:31:34,767 DEBUG : BROWSER_OUTPUT: __startTimestamp1450380694755__endTimestamp 11:31:34 INFO - 2015-12-17 11:31:34,767 DEBUG : BROWSER_OUTPUT: 11:31:34 INFO - 2015-12-17 11:31:34,767 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:31:34 INFO - 2015-12-17 11:31:34,767 DEBUG : BROWSER_OUTPUT: Number of tests: 6 11:31:34 INFO - 2015-12-17 11:31:34,767 DEBUG : BROWSER_OUTPUT: 11:31:34 INFO - 2015-12-17 11:31:34,767 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5713.51 Median:5924.73 stddev:635.73 (10.7%) stddev-sans-first:611.20 11:31:34 INFO - 2015-12-17 11:31:34,768 DEBUG : BROWSER_OUTPUT: Values: 3399.3 3412.7 3426.7 3441.6 3473.9 5706.4 5713.6 5746.4 5752.0 5759.0 5706.7 5711.9 5752.5 5756.2 5758.2 5117.6 5234.3 5247.4 5308.4 5330.0 5222.4 5222.5 5232.3 5256.7 5320.1 5331.1 5349.6 5364.9 5367.0 5370.3 5277.9 5280.6 5339.0 5351.3 5375.8 5078.8 5105.5 5152.8 5158.1 5175.2 5488.5 5489.2 5492.9 5511.9 5516.6 5815.9 6128.0 6145.9 6147.8 6164.8 6009.3 6124.8 6246.7 6249.2 6267.1 5795.2 5809.9 5810.0 5812.1 5846.7 6020.5 6118.7 6290.2 6317.7 6322.7 6022.9 6101.8 6111.2 6112.5 6117.2 6186.4 6218.4 6220.7 6231.3 6242.5 5938.5 6078.1 6088.9 6178.8 6188.4 6103.5 6104.5 6105.7 6106.5 6129.7 4722.9 4725.4 4731.7 4737.4 4759.5 4115.4 4160.3 4203.3 4214.5 4235.9 5679.7 5684.0 5688.3 5688.5 5760.5 6180.8 6184.3 6185.3 6191.9 6193.5 5567.3 5673.7 5685.2 5771.0 5771.2 5348.4 5354.7 5389.6 5391.4 5392.0 6072.4 6387.1 6396.5 6399.2 6400.9 6071.4 6125.6 6159.4 6160.2 6178.3 6363.6 6456.5 6471.5 6476.6 6476.9 5909.6 6033.3 6157.1 6197.2 6200.4 6047.5 6151.9 6155.2 6159.8 6162.2 6039.2 6118.6 6120.1 6120.6 6121.7 5802.4 5924.7 5984.6 6060.3 6099.7 5971.4 5983.0 5990.8 5992.2 6004.0 6042.3 6081.2 6094.7 6101.0 6107.5 5721.6 5776.0 5832.5 5914.1 5949.8 11:31:34 INFO - 2015-12-17 11:31:34,769 DEBUG : BROWSER_OUTPUT: 11:31:34 INFO - 2015-12-17 11:31:34,769 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:56561.45 Median:35884.77 stddev:95460.08 (266.0%) stddev-sans-first:95635.41 11:31:34 INFO - 2015-12-17 11:31:34,769 DEBUG : BROWSER_OUTPUT: Values: 602.9 635.7 637.0 672.2 679.3 40783.4 41095.0 41109.8 41222.0 41316.8 45018.0 45590.8 45604.0 45627.3 45637.3 8040.3 8177.8 9186.2 9360.9 10633.1 10868.5 10879.0 10914.6 10926.7 10968.7 11033.6 11135.2 11137.3 11139.9 11149.3 10950.2 11033.7 11034.4 11047.2 11049.9 10921.6 10928.2 11009.5 11030.4 11051.2 44416.6 44816.1 44845.6 44883.6 44919.6 3717.6 3767.7 3793.9 3804.1 3827.8 31787.5 31876.7 34309.5 34586.3 34949.3 3388.7 3406.0 3445.4 3488.7 3563.9 303878.0 310946.4 312146.0 313274.0 313408.0 61874.4 63320.7 72344.6 72740.6 73119.0 80291.6 81060.6 81313.0 81374.0 81386.6 17626.8 17654.6 17757.4 17804.0 17849.9 14754.1 14945.6 14955.2 14965.3 14967.3 24510.3 24799.1 24891.0 24906.5 25020.1 9340.3 9486.4 9549.1 9693.0 9835.2 998.0 1145.9 1155.9 1181.8 1202.4 30711.7 31415.0 31582.2 35411.0 35746.0 1103.1 1209.4 1246.0 1250.7 1255.2 14669.4 15818.8 15878.0 16138.4 17260.5 415071.0 420064.0 420656.0 420944.0 422344.0 60996.4 61617.4 61622.7 61645.0 61673.1 1426.5 1479.0 1531.4 1561.4 1598.4 31637.1 31692.5 32295.5 34118.7 35405.6 57308.7 57920.4 58015.4 58073.7 58087.1 349091.0 354770.0 354983.0 355070.0 356473.0 47652.3 48015.0 48574.3 48948.8 49023.5 51943.5 52106.5 52524.0 52731.7 53561.0 42697.6 43581.8 43726.8 44554.3 45025.0 46782.0 47078.5 48561.8 48895.3 49280.8 42052.6 42302.6 47026.5 47752.3 47771.8 35434.8 36023.5 36716.4 37345.6 37488.4 27967.9 28623.7 28656.1 28873.4 28987.7 11:31:34 INFO - 2015-12-17 11:31:34,769 DEBUG : BROWSER_OUTPUT: 11:31:34 INFO - 2015-12-17 11:31:34,769 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:32158.30 Median:4649.52 stddev:112156.95 (2412.2%) stddev-sans-first:112446.19 11:31:34 INFO - 2015-12-17 11:31:34,769 DEBUG : BROWSER_OUTPUT: Values: 384.5 388.5 390.2 391.0 394.4 13614.7 14161.6 18232.4 20666.0 20698.6 13073.8 13386.8 13402.1 19003.7 20714.4 4721.5 4817.9 4832.0 4833.1 4837.4 4807.6 4849.7 4850.3 4852.7 4854.0 3826.3 4428.7 4810.3 4814.6 4816.5 5126.6 5154.3 5169.4 5177.5 5191.7 4461.2 4560.3 4565.0 4574.8 4577.5 15340.6 15749.4 15765.8 15788.5 15835.8 2207.8 2262.8 2297.0 2338.2 2375.8 10501.8 11014.0 11050.2 11146.8 11274.2 1785.1 1807.9 1855.6 1872.0 1899.7 66664.3 67063.3 68013.7 68384.3 68675.0 7624.5 7751.8 7893.5 7945.3 7955.2 9524.7 9529.8 9546.0 9573.8 9585.0 6265.1 6311.7 6316.3 6317.3 6423.5 6602.3 6713.7 6722.9 6733.6 6734.1 3640.3 3657.8 3666.7 3694.7 3697.3 1261.4 1286.7 1287.3 1290.1 1319.7 418.0 526.7 534.9 539.2 551.0 13032.7 13329.1 13502.1 13530.5 13591.9 528.5 531.0 539.6 554.6 597.6 6599.9 7306.2 7347.2 7414.4 7464.7 664663.0 681517.0 685139.0 693095.0 701156.0 67039.3 74792.3 87654.6 88627.6 89335.6 596.8 609.4 610.2 610.7 612.2 11728.9 11968.8 12200.6 12288.8 12321.4 38772.8 38919.4 39184.0 39806.0 40128.4 48554.3 50761.0 50986.5 53006.0 53522.7 7431.2 7588.4 7594.8 7655.9 7675.0 6307.6 13531.5 13824.8 13890.9 14127.1 9636.8 11910.7 11952.6 11959.5 11994.5 11051.4 11256.6 11660.6 11695.0 12005.3 11591.8 11841.6 11891.9 11959.4 11959.5 7430.7 7483.7 7502.0 7508.9 7525.5 11684.0 11860.5 11963.6 12316.5 12320.4 11:31:34 INFO - 2015-12-17 11:31:34,769 DEBUG : BROWSER_OUTPUT: 11:31:34 INFO - 2015-12-17 11:31:34,769 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5918.82 Median:5170.66 stddev:3034.37 (58.7%) stddev-sans-first:3025.23 11:31:34 INFO - 2015-12-17 11:31:34,770 DEBUG : BROWSER_OUTPUT: Values: 1563.8 1569.5 1787.2 1846.6 1860.3 7199.6 7298.2 8126.6 8338.2 8344.7 7993.7 8027.2 8137.3 8139.5 8155.2 2350.4 2419.1 2424.5 2425.6 2426.4 2174.4 2206.2 2465.5 2469.2 2492.5 2426.5 2427.3 2429.9 2452.5 2455.6 2427.4 2437.3 2452.8 2455.9 2457.3 2430.2 2471.0 2472.9 2475.2 2475.7 8192.7 8224.5 8244.1 8248.8 8295.5 5057.5 5108.4 5118.9 5126.0 5133.9 3338.6 3341.2 3472.5 3495.1 3505.2 1115.5 1132.1 1143.9 1146.8 1199.6 11407.3 11527.5 11558.9 11560.8 11562.5 4616.2 4649.0 4653.6 4680.5 4682.8 9908.2 9933.9 9936.9 9943.2 9944.5 5163.3 5168.8 5172.6 5176.9 5178.7 4692.8 4692.9 4697.7 4698.4 4703.7 3529.8 3921.1 3934.4 3983.1 3985.9 1237.4 1273.1 1275.6 1279.4 1296.0 1134.7 1396.2 1449.0 1458.3 1485.2 7957.3 7984.7 8010.6 8059.7 8067.0 1157.8 1164.2 1171.5 1251.4 1252.9 6248.1 6267.1 6300.3 6308.6 6311.9 10007.2 10103.9 10162.9 10178.0 10183.2 9829.8 10017.6 10048.4 10063.0 10075.4 7783.9 7846.1 7849.3 7858.8 7861.5 7629.9 7706.7 7712.8 7726.4 7740.4 8534.4 8959.6 8977.6 9014.5 9120.9 8931.0 9013.6 9104.8 9346.9 9348.2 8031.4 8090.2 8163.0 8167.3 8169.7 7259.2 7335.7 8121.6 8173.3 8185.7 7641.8 7650.4 7703.1 7817.4 7834.1 7472.6 7638.7 7642.4 7760.5 7785.5 7693.1 7716.2 7730.5 7879.2 7890.4 7226.3 7267.1 7312.6 7313.5 7315.9 7076.8 7126.6 7132.2 7311.8 7322.4 11:31:34 INFO - 2015-12-17 11:31:34,770 DEBUG : BROWSER_OUTPUT: 11:31:34 INFO - 2015-12-17 11:31:34,771 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5329.41 Median:6027.89 stddev:1578.38 (26.2%) stddev-sans-first:1537.81 11:31:34 INFO - 2015-12-17 11:31:34,771 DEBUG : BROWSER_OUTPUT: Values: 343.6 354.7 363.4 364.7 369.1 5861.3 5956.1 6004.8 6008.9 6017.9 5779.1 5897.4 5909.3 5909.9 5917.7 4622.7 4632.4 4640.3 4643.2 4643.8 4428.4 4491.2 4558.7 4633.1 4643.7 4579.0 4592.2 4598.8 4602.7 4604.6 4585.0 4592.7 4593.2 4593.9 4604.1 4050.8 4052.9 4057.9 4058.0 4064.4 5575.4 5654.9 5687.6 5724.9 5726.2 5395.9 5400.3 5407.8 5411.4 5413.5 6037.8 6349.1 6357.0 6357.8 6359.2 4362.6 4465.7 4516.8 4522.3 4532.6 6457.8 6461.2 6470.7 6491.6 6497.4 4626.3 4627.5 4628.8 4629.8 4630.0 4528.1 4594.9 4635.0 4691.1 4695.2 5268.6 5291.2 5291.6 5292.0 5292.8 6289.4 6296.4 6309.1 6328.0 6331.9 1644.9 1656.4 1657.1 1657.7 1658.6 1104.3 1115.2 1120.4 1127.3 1141.6 6090.3 6113.0 6125.3 6125.9 6131.7 6469.3 6474.3 6526.2 6528.6 6536.8 5985.3 6093.7 6103.0 6104.2 6108.0 3595.4 3624.8 3627.2 3627.3 3628.7 6735.3 6745.5 6746.0 6746.5 6747.7 6629.5 6711.1 6719.4 6729.7 6729.8 6723.3 6752.2 6758.8 6763.5 6766.1 6318.6 6411.2 6441.1 6532.5 6538.7 6430.4 6445.2 6466.7 6474.8 6476.4 6669.9 6689.1 6702.2 6704.6 6711.7 4472.1 4582.2 4582.3 4587.8 4611.1 6516.8 6630.2 6634.7 6642.9 6646.5 6443.3 6451.5 6453.9 6456.0 6466.2 6343.1 6456.8 6461.1 6462.9 6467.2 6310.3 6313.3 6314.5 6317.7 6359.1 6453.9 6456.9 6458.8 6464.0 6485.0 6156.6 6262.8 6285.3 6302.2 6324.1 11:31:34 INFO - 2015-12-17 11:31:34,771 DEBUG : BROWSER_OUTPUT: 11:31:34 INFO - 2015-12-17 11:31:34,771 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:15270.80 Median:4818.72 stddev:18454.21 (383.0%) stddev-sans-first:18474.41 11:31:34 INFO - 2015-12-17 11:31:34,771 DEBUG : BROWSER_OUTPUT: Values: 896.0 897.4 934.1 934.3 972.2 15256.2 16500.9 16506.2 16507.8 16515.3 15142.4 15196.2 15214.2 15222.4 15236.5 790.7 794.0 922.0 933.4 955.3 926.7 929.1 934.9 936.0 936.4 810.9 992.8 1008.0 1009.2 1010.1 813.4 959.8 977.3 978.5 979.0 721.7 724.8 725.5 726.7 727.9 13480.0 13538.0 13541.9 13554.6 13574.0 13821.4 13848.7 13957.2 13974.6 14153.1 10179.9 10511.4 10531.6 10532.4 10648.5 3509.6 3548.0 3554.6 3555.6 3559.8 53860.5 53907.5 54003.7 54263.0 55608.0 8179.8 8224.3 8244.1 8283.5 11012.3 14313.9 14421.9 14447.4 14458.6 14470.1 7676.2 7830.6 7832.3 7846.8 7914.3 4484.3 4565.8 4575.7 4588.9 4602.3 3174.8 3185.2 3196.7 3199.2 3202.4 473.6 479.9 481.5 485.7 498.4 706.4 713.0 720.8 738.5 747.9 9208.3 9489.0 9513.3 9584.5 9627.2 571.9 662.7 667.2 676.8 769.5 4656.5 4755.0 4773.8 4818.3 4819.2 66576.3 66686.3 66719.0 66874.3 66993.7 54448.7 55256.7 55341.4 55749.7 56435.0 53861.5 54150.2 55147.4 55492.4 55918.4 9358.7 9381.0 9390.0 9622.8 9709.8 40932.8 41169.8 41218.8 42001.2 42042.0 49419.5 53834.7 53847.5 54307.2 54466.5 8453.7 8586.0 9088.3 9120.9 9123.0 13088.9 13146.9 13361.9 13378.1 13644.0 12750.4 12811.7 12818.2 12986.5 13222.7 11631.7 11637.4 11696.2 11750.7 12032.2 12586.4 12617.6 12703.5 13041.8 13296.5 10190.3 10771.8 10797.7 10890.8 11393.5 10303.9 10343.7 10344.6 10371.9 10463.6 11:31:34 INFO - 2015-12-17 11:31:34,771 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:31:34 INFO - 2015-12-17 11:31:34,771 DEBUG : BROWSER_OUTPUT: 11:31:35 INFO - 2015-12-17 11:31:35,341 INFO : Browser exited with error code: 0 11:31:35 INFO - 2015-12-17 11:31:35,360 INFO : Completed test dromaeo_css (00:18:29) 11:31:35 INFO - 2015-12-17 11:31:35,360 INFO : Starting test kraken 11:31:35 INFO - 2015-12-17 11:31:35,360 DEBUG : operating with platform_type : linux_ 11:31:35 INFO - 2015-12-17 11:31:35,360 INFO : Initialising browser for kraken test... 11:31:35 INFO - 2015-12-17 11:31:35,367 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpAIGuyP/profile http://localhost:51769/getInfo.html 11:31:39 INFO - 2015-12-17 11:31:39,064 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:31:39 INFO - 2015-12-17 11:31:39,065 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:31:39 INFO - 2015-12-17 11:31:39,065 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:31:39 INFO - 2015-12-17 11:31:39,065 DEBUG : BROWSER_OUTPUT: __metrics 11:31:39 INFO - 2015-12-17 11:31:39,167 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] 11:31:40 INFO - 2015-12-17 11:31:40,313 INFO : Browser initialized. 11:31:40 INFO - 2015-12-17 11:31:40,314 INFO : Running cycle 1/1 for kraken test... 11:31:40 INFO - 2015-12-17 11:31:40,314 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpAIGuyP/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:31:51 INFO - 2015-12-17 11:31:51,864 DEBUG : BROWSER_OUTPUT: RSS: Main: 128770048 11:31:51 INFO - 2015-12-17 11:31:51,864 DEBUG : BROWSER_OUTPUT: 11:31:54 INFO - 2015-12-17 11:31:54,298 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51769/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51769/tests/kraken/driver.html?testName=audio-beat-detection) 11:31:54 INFO - 2015-12-17 11:31:54,864 DEBUG : BROWSER_OUTPUT: RSS: Main: 164827136 11:31:54 INFO - 2015-12-17 11:31:54,864 DEBUG : BROWSER_OUTPUT: 11:31:57 INFO - 2015-12-17 11:31:57,422 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51769/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51769/tests/kraken/driver.html?testName=audio-dft) 11:31:57 INFO - 2015-12-17 11:31:57,983 DEBUG : BROWSER_OUTPUT: RSS: Main: 159965184 11:31:57 INFO - 2015-12-17 11:31:57,984 DEBUG : BROWSER_OUTPUT: 11:32:00 INFO - 2015-12-17 11:32:00,746 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51769/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51769/tests/kraken/driver.html?testName=audio-fft) 11:32:01 INFO - 2015-12-17 11:32:01,308 DEBUG : BROWSER_OUTPUT: RSS: Main: 158089216 11:32:01 INFO - 2015-12-17 11:32:01,308 DEBUG : BROWSER_OUTPUT: 11:32:03 INFO - 2015-12-17 11:32:03,272 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51769/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51769/tests/kraken/driver.html?testName=audio-oscillator) 11:32:03 INFO - 2015-12-17 11:32:03,833 DEBUG : BROWSER_OUTPUT: RSS: Main: 158281728 11:32:03 INFO - 2015-12-17 11:32:03,834 DEBUG : BROWSER_OUTPUT: 11:32:05 INFO - 2015-12-17 11:32:05,975 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51769/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51769/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:32:06 INFO - 2015-12-17 11:32:06,536 DEBUG : BROWSER_OUTPUT: RSS: Main: 157093888 11:32:06 INFO - 2015-12-17 11:32:06,536 DEBUG : BROWSER_OUTPUT: 11:32:09 INFO - 2015-12-17 11:32:09,418 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51769/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51769/tests/kraken/driver.html?testName=imaging-darkroom) 11:32:09 INFO - 2015-12-17 11:32:09,985 DEBUG : BROWSER_OUTPUT: RSS: Main: 155553792 11:32:09 INFO - 2015-12-17 11:32:09,985 DEBUG : BROWSER_OUTPUT: 11:32:13 INFO - 2015-12-17 11:32:13,313 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51769/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51769/tests/kraken/driver.html?testName=imaging-desaturate) 11:32:13 INFO - 2015-12-17 11:32:13,879 DEBUG : BROWSER_OUTPUT: RSS: Main: 156606464 11:32:13 INFO - 2015-12-17 11:32:13,880 DEBUG : BROWSER_OUTPUT: 11:32:16 INFO - 2015-12-17 11:32:16,568 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51769/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51769/tests/kraken/driver.html?testName=json-parse-financial) 11:32:17 INFO - 2015-12-17 11:32:17,141 DEBUG : BROWSER_OUTPUT: RSS: Main: 156385280 11:32:17 INFO - 2015-12-17 11:32:17,141 DEBUG : BROWSER_OUTPUT: 11:32:18 INFO - 2015-12-17 11:32:18,628 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51769/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51769/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:32:19 INFO - 2015-12-17 11:32:19,194 DEBUG : BROWSER_OUTPUT: RSS: Main: 159768576 11:32:19 INFO - 2015-12-17 11:32:19,194 DEBUG : BROWSER_OUTPUT: 11:32:20 INFO - 2015-12-17 11:32:20,916 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51769/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51769/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:32:21 INFO - 2015-12-17 11:32:21,509 DEBUG : BROWSER_OUTPUT: RSS: Main: 159858688 11:32:21 INFO - 2015-12-17 11:32:21,510 DEBUG : BROWSER_OUTPUT: 11:32:23 INFO - 2015-12-17 11:32:23,460 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51769/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51769/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:32:24 INFO - 2015-12-17 11:32:24,030 DEBUG : BROWSER_OUTPUT: RSS: Main: 166064128 11:32:24 INFO - 2015-12-17 11:32:24,030 DEBUG : BROWSER_OUTPUT: 11:32:26 INFO - 2015-12-17 11:32:26,309 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51769/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51769/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:32:26 INFO - 2015-12-17 11:32:26,882 DEBUG : BROWSER_OUTPUT: RSS: Main: 169054208 11:32:26 INFO - 2015-12-17 11:32:26,882 DEBUG : BROWSER_OUTPUT: 11:32:29 INFO - 2015-12-17 11:32:29,282 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51769/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51769/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:32:29 INFO - 2015-12-17 11:32:29,851 DEBUG : BROWSER_OUTPUT: RSS: Main: 167268352 11:32:29 INFO - 2015-12-17 11:32:29,851 DEBUG : BROWSER_OUTPUT: 11:32:31 INFO - 2015-12-17 11:32:31,486 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51769/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51769/tests/kraken/driver.html?testName=ai-astar) 11:32:31 INFO - 2015-12-17 11:32:31,736 DEBUG : BROWSER_OUTPUT: RSS: Main: 225325056 11:32:31 INFO - 2015-12-17 11:32:31,737 DEBUG : BROWSER_OUTPUT: 11:32:31 INFO - 2015-12-17 11:32:31,737 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:32:31 INFO - 2015-12-17 11:32:31,737 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:32:31 INFO - 2015-12-17 11:32:31,737 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:32:31 INFO - 2015-12-17 11:32:31,737 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:32:31 INFO - 2015-12-17 11:32:31,737 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;110;104;110;112;111;101;110;105;109 11:32:31 INFO - 2015-12-17 11:32:31,737 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;148;120;146;157;123;156;148;123;170;123 11:32:31 INFO - 2015-12-17 11:32:31,738 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;160;159;160;160;159;158;164;160;161 11:32:31 INFO - 2015-12-17 11:32:31,738 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;72;147;72;71;70;71;155;82 11:32:31 INFO - 2015-12-17 11:32:31,738 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;90;88;145;93;90;90;128;88;89;134 11:32:31 INFO - 2015-12-17 11:32:31,738 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;109;109;110;109;109;109;109;109 11:32:31 INFO - 2015-12-17 11:32:31,738 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;145;146;145;146;145;146;145;145;145 11:32:31 INFO - 2015-12-17 11:32:31,738 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;96;95;96;96;96;95;96;96 11:32:31 INFO - 2015-12-17 11:32:31,739 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;54;55;54;54;55;55;57;64;53;53 11:32:31 INFO - 2015-12-17 11:32:31,739 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;63;65;64;64;63;64;64;63;63;63 11:32:31 INFO - 2015-12-17 11:32:31,740 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;78;79;77;80;80;85;80;79;78;79 11:32:31 INFO - 2015-12-17 11:32:31,740 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;108;115;112;109;110;111;110;109;119;122 11:32:31 INFO - 2015-12-17 11:32:31,740 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;138;129;135;134;135;134;136;135;146;126 11:32:31 INFO - 2015-12-17 11:32:31,741 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;63;64;64;62;65;61;62;63;63;64 11:32:31 INFO - 2015-12-17 11:32:31,741 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:32:31 INFO - 2015-12-17 11:32:31,741 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:32:31 INFO - 2015-12-17 11:32:31,741 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,869 11:32:31 INFO - 2015-12-17 11:32:31,741 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:32:31 INFO - 2015-12-17 11:32:31,741 DEBUG : BROWSER_OUTPUT: __startTimestamp1450380751736__endTimestamp 11:32:31 INFO - 2015-12-17 11:32:31,741 DEBUG : BROWSER_OUTPUT: 11:32:31 INFO - 2015-12-17 11:32:31,742 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:32:31 INFO - 2015-12-17 11:32:31,742 DEBUG : BROWSER_OUTPUT: Number of tests: 14 11:32:31 INFO - 2015-12-17 11:32:31,743 DEBUG : BROWSER_OUTPUT: 11:32:31 INFO - 2015-12-17 11:32:31,743 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.10 Median:110.00 stddev:3.54 (3.2%) stddev-sans-first:3.74 11:32:31 INFO - 2015-12-17 11:32:31,743 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 104.0 110.0 112.0 111.0 101.0 110.0 105.0 109.0 11:32:31 INFO - 2015-12-17 11:32:31,743 DEBUG : BROWSER_OUTPUT: 11:32:31 INFO - 2015-12-17 11:32:31,743 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:141.40 Median:148.00 stddev:17.82 (12.0%) stddev-sans-first:18.73 11:32:31 INFO - 2015-12-17 11:32:31,743 DEBUG : BROWSER_OUTPUT: Values: 148.0 120.0 146.0 157.0 123.0 156.0 148.0 123.0 170.0 123.0 11:32:31 INFO - 2015-12-17 11:32:31,743 DEBUG : BROWSER_OUTPUT: 11:32:31 INFO - 2015-12-17 11:32:31,743 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.20 Median:160.00 stddev:1.62 (1.0%) stddev-sans-first:1.69 11:32:31 INFO - 2015-12-17 11:32:31,743 DEBUG : BROWSER_OUTPUT: Values: 161.0 160.0 159.0 160.0 160.0 159.0 158.0 164.0 160.0 161.0 11:32:31 INFO - 2015-12-17 11:32:31,743 DEBUG : BROWSER_OUTPUT: 11:32:31 INFO - 2015-12-17 11:32:31,743 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:88.40 Median:72.00 stddev:33.22 (46.1%) stddev-sans-first:34.70 11:32:31 INFO - 2015-12-17 11:32:31,743 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 72.0 147.0 72.0 71.0 70.0 71.0 155.0 82.0 11:32:31 INFO - 2015-12-17 11:32:31,744 DEBUG : BROWSER_OUTPUT: 11:32:31 INFO - 2015-12-17 11:32:31,744 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:103.50 Median:89.50 stddev:22.61 (25.3%) stddev-sans-first:23.45 11:32:31 INFO - 2015-12-17 11:32:31,744 DEBUG : BROWSER_OUTPUT: Values: 90.0 88.0 145.0 93.0 90.0 90.0 128.0 88.0 89.0 134.0 11:32:31 INFO - 2015-12-17 11:32:31,744 DEBUG : BROWSER_OUTPUT: 11:32:31 INFO - 2015-12-17 11:32:31,744 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 11:32:31 INFO - 2015-12-17 11:32:31,744 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 109.0 109.0 110.0 109.0 109.0 109.0 109.0 109.0 11:32:31 INFO - 2015-12-17 11:32:31,744 DEBUG : BROWSER_OUTPUT: 11:32:31 INFO - 2015-12-17 11:32:31,744 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 11:32:31 INFO - 2015-12-17 11:32:31,744 DEBUG : BROWSER_OUTPUT: Values: 146.0 145.0 146.0 145.0 146.0 145.0 146.0 145.0 145.0 145.0 11:32:31 INFO - 2015-12-17 11:32:31,744 DEBUG : BROWSER_OUTPUT: 11:32:31 INFO - 2015-12-17 11:32:31,744 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 11:32:31 INFO - 2015-12-17 11:32:31,744 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 96.0 95.0 96.0 96.0 96.0 95.0 96.0 96.0 11:32:31 INFO - 2015-12-17 11:32:31,745 DEBUG : BROWSER_OUTPUT: 11:32:31 INFO - 2015-12-17 11:32:31,745 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:55.40 Median:55.00 stddev:3.24 (5.9%) stddev-sans-first:3.40 11:32:31 INFO - 2015-12-17 11:32:31,745 DEBUG : BROWSER_OUTPUT: Values: 54.0 55.0 54.0 54.0 55.0 55.0 57.0 64.0 53.0 53.0 11:32:31 INFO - 2015-12-17 11:32:31,745 DEBUG : BROWSER_OUTPUT: 11:32:31 INFO - 2015-12-17 11:32:31,745 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:63.60 Median:64.00 stddev:0.70 (1.1%) stddev-sans-first:0.71 11:32:31 INFO - 2015-12-17 11:32:31,745 DEBUG : BROWSER_OUTPUT: Values: 63.0 65.0 64.0 64.0 63.0 64.0 64.0 63.0 63.0 63.0 11:32:31 INFO - 2015-12-17 11:32:31,745 DEBUG : BROWSER_OUTPUT: 11:32:31 INFO - 2015-12-17 11:32:31,745 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:79.50 Median:79.50 stddev:2.17 (2.7%) stddev-sans-first:2.24 11:32:31 INFO - 2015-12-17 11:32:31,745 DEBUG : BROWSER_OUTPUT: Values: 78.0 79.0 77.0 80.0 80.0 85.0 80.0 79.0 78.0 79.0 11:32:31 INFO - 2015-12-17 11:32:31,745 DEBUG : BROWSER_OUTPUT: 11:32:31 INFO - 2015-12-17 11:32:31,745 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:112.50 Median:111.50 stddev:4.70 (4.2%) stddev-sans-first:4.69 11:32:31 INFO - 2015-12-17 11:32:31,746 DEBUG : BROWSER_OUTPUT: Values: 108.0 115.0 112.0 109.0 110.0 111.0 110.0 109.0 119.0 122.0 11:32:31 INFO - 2015-12-17 11:32:31,746 DEBUG : BROWSER_OUTPUT: 11:32:31 INFO - 2015-12-17 11:32:31,746 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:134.80 Median:135.00 stddev:5.27 (3.9%) stddev-sans-first:5.46 11:32:31 INFO - 2015-12-17 11:32:31,746 DEBUG : BROWSER_OUTPUT: Values: 138.0 129.0 135.0 134.0 135.0 134.0 136.0 135.0 146.0 126.0 11:32:31 INFO - 2015-12-17 11:32:31,746 DEBUG : BROWSER_OUTPUT: 11:32:31 INFO - 2015-12-17 11:32:31,746 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.10 Median:63.50 stddev:1.20 (1.9%) stddev-sans-first:1.27 11:32:31 INFO - 2015-12-17 11:32:31,746 DEBUG : BROWSER_OUTPUT: Values: 63.0 64.0 64.0 62.0 65.0 61.0 62.0 63.0 63.0 64.0 11:32:31 INFO - 2015-12-17 11:32:31,746 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:32:31 INFO - 2015-12-17 11:32:31,746 DEBUG : BROWSER_OUTPUT: 11:32:32 INFO - 2015-12-17 11:32:32,369 INFO : Browser exited with error code: 0 11:32:32 INFO - 2015-12-17 11:32:32,418 INFO : Completed test kraken (00:00:57) 11:32:32 INFO - 2015-12-17 11:32:32,418 INFO : Starting test v8_7 11:32:32 INFO - 2015-12-17 11:32:32,418 DEBUG : operating with platform_type : linux_ 11:32:32 INFO - 2015-12-17 11:32:32,418 INFO : Initialising browser for v8_7 test... 11:32:32 INFO - 2015-12-17 11:32:32,425 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpp4nV6t/profile http://localhost:51769/getInfo.html 11:32:36 INFO - 2015-12-17 11:32:36,058 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:32:36 INFO - 2015-12-17 11:32:36,058 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:32:36 INFO - 2015-12-17 11:32:36,058 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:32:36 INFO - 2015-12-17 11:32:36,058 DEBUG : BROWSER_OUTPUT: __metrics 11:32:36 INFO - 2015-12-17 11:32:36,203 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] 11:32:37 INFO - 2015-12-17 11:32:37,421 INFO : Browser initialized. 11:32:37 INFO - 2015-12-17 11:32:37,422 INFO : Running cycle 1/1 for v8_7 test... 11:32:37 INFO - 2015-12-17 11:32:37,422 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpp4nV6t/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:32:49 INFO - 2015-12-17 11:32:49,004 DEBUG : BROWSER_OUTPUT: RSS: Main: 128589824 11:32:49 INFO - 2015-12-17 11:32:49,004 DEBUG : BROWSER_OUTPUT: 11:33:10 INFO - 2015-12-17 11:33:10,319 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51769/tests/v8_7/run.html (next: http://localhost:51769/tests/v8_7/run.html) 11:33:10 INFO - 2015-12-17 11:33:10,569 DEBUG : BROWSER_OUTPUT: RSS: Main: 420626432 11:33:10 INFO - 2015-12-17 11:33:10,569 DEBUG : BROWSER_OUTPUT: 11:33:10 INFO - 2015-12-17 11:33:10,569 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:33:10 INFO - 2015-12-17 11:33:10,569 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:33:10 INFO - 2015-12-17 11:33:10,569 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:33:10 INFO - 2015-12-17 11:33:10,570 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:33:10 INFO - 2015-12-17 11:33:10,570 DEBUG : BROWSER_OUTPUT: |0;Richards;163.371998039536 11:33:10 INFO - 2015-12-17 11:33:10,570 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;171.32088401576152 11:33:10 INFO - 2015-12-17 11:33:10,570 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.3296089385475 11:33:10 INFO - 2015-12-17 11:33:10,570 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5000 11:33:10 INFO - 2015-12-17 11:33:10,570 DEBUG : BROWSER_OUTPUT: |4;RayTrace;939.8496240601504 11:33:10 INFO - 2015-12-17 11:33:10,570 DEBUG : BROWSER_OUTPUT: |5;Earley;551.8763796909492 11:33:10 INFO - 2015-12-17 11:33:10,570 DEBUG : BROWSER_OUTPUT: |6;Boyer;10479.166666666666 11:33:10 INFO - 2015-12-17 11:33:10,570 DEBUG : BROWSER_OUTPUT: |7;RegExp;23904.761904761905 11:33:10 INFO - 2015-12-17 11:33:10,570 DEBUG : BROWSER_OUTPUT: |8;Splay;529.6296296296297 11:33:10 INFO - 2015-12-17 11:33:10,571 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4812.5 11:33:10 INFO - 2015-12-17 11:33:10,571 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:33:10 INFO - 2015-12-17 11:33:10,571 DEBUG : BROWSER_OUTPUT: __startTimestamp1450380790568__endTimestamp 11:33:10 INFO - 2015-12-17 11:33:10,571 DEBUG : BROWSER_OUTPUT: 11:33:10 INFO - 2015-12-17 11:33:10,571 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:33:10 INFO - 2015-12-17 11:33:10,571 DEBUG : BROWSER_OUTPUT: Number of tests: 10 11:33:10 INFO - 2015-12-17 11:33:10,571 DEBUG : BROWSER_OUTPUT: 11:33:10 INFO - 2015-12-17 11:33:10,571 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:163.37 Median:163.37 stddev:0.00 (0.0%) 11:33:10 INFO - 2015-12-17 11:33:10,571 DEBUG : BROWSER_OUTPUT: Values: 163.4 11:33:10 INFO - 2015-12-17 11:33:10,571 DEBUG : BROWSER_OUTPUT: 11:33:10 INFO - 2015-12-17 11:33:10,572 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:171.32 Median:171.32 stddev:0.00 (0.0%) 11:33:10 INFO - 2015-12-17 11:33:10,572 DEBUG : BROWSER_OUTPUT: Values: 171.3 11:33:10 INFO - 2015-12-17 11:33:10,572 DEBUG : BROWSER_OUTPUT: 11:33:10 INFO - 2015-12-17 11:33:10,572 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.33 Median:279.33 stddev:0.00 (0.0%) 11:33:10 INFO - 2015-12-17 11:33:10,572 DEBUG : BROWSER_OUTPUT: Values: 279.3 11:33:10 INFO - 2015-12-17 11:33:10,572 DEBUG : BROWSER_OUTPUT: 11:33:10 INFO - 2015-12-17 11:33:10,572 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5000.00 Median:5000.00 stddev:0.00 (0.0%) 11:33:10 INFO - 2015-12-17 11:33:10,572 DEBUG : BROWSER_OUTPUT: Values: 5000.0 11:33:10 INFO - 2015-12-17 11:33:10,573 DEBUG : BROWSER_OUTPUT: 11:33:10 INFO - 2015-12-17 11:33:10,573 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:939.85 Median:939.85 stddev:0.00 (0.0%) 11:33:10 INFO - 2015-12-17 11:33:10,573 DEBUG : BROWSER_OUTPUT: Values: 939.8 11:33:10 INFO - 2015-12-17 11:33:10,573 DEBUG : BROWSER_OUTPUT: 11:33:10 INFO - 2015-12-17 11:33:10,573 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:551.88 Median:551.88 stddev:0.00 (0.0%) 11:33:10 INFO - 2015-12-17 11:33:10,573 DEBUG : BROWSER_OUTPUT: Values: 551.9 11:33:10 INFO - 2015-12-17 11:33:10,573 DEBUG : BROWSER_OUTPUT: 11:33:10 INFO - 2015-12-17 11:33:10,573 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10479.17 Median:10479.17 stddev:0.00 (0.0%) 11:33:10 INFO - 2015-12-17 11:33:10,574 DEBUG : BROWSER_OUTPUT: Values: 10479.2 11:33:10 INFO - 2015-12-17 11:33:10,574 DEBUG : BROWSER_OUTPUT: 11:33:10 INFO - 2015-12-17 11:33:10,574 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:23904.76 Median:23904.76 stddev:0.00 (0.0%) 11:33:10 INFO - 2015-12-17 11:33:10,574 DEBUG : BROWSER_OUTPUT: Values: 23904.8 11:33:10 INFO - 2015-12-17 11:33:10,574 DEBUG : BROWSER_OUTPUT: 11:33:10 INFO - 2015-12-17 11:33:10,574 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:529.63 Median:529.63 stddev:0.00 (0.0%) 11:33:10 INFO - 2015-12-17 11:33:10,574 DEBUG : BROWSER_OUTPUT: Values: 529.6 11:33:10 INFO - 2015-12-17 11:33:10,574 DEBUG : BROWSER_OUTPUT: 11:33:10 INFO - 2015-12-17 11:33:10,574 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4812.50 Median:4812.50 stddev:0.00 (0.0%) 11:33:10 INFO - 2015-12-17 11:33:10,574 DEBUG : BROWSER_OUTPUT: Values: 4812.5 11:33:10 INFO - 2015-12-17 11:33:10,574 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:33:10 INFO - 2015-12-17 11:33:10,574 DEBUG : BROWSER_OUTPUT: 11:33:11 INFO - 2015-12-17 11:33:11,237 INFO : Browser exited with error code: 0 11:33:11 INFO - 2015-12-17 11:33:11,249 INFO : Completed test v8_7 (00:00:38) 11:33:11 INFO - 2015-12-17 11:33:11,654 INFO : Completed test suite (00:20:06) 11:33:11 INFO - 2015-12-17 11:33:11,654 DEBUG : Working with test: dromaeo_css 11:33:11 INFO - 2015-12-17 11:33:11,654 DEBUG : Generating results file: dromaeo_css 11:33:11 INFO - 2015-12-17 11:33:11,655 DEBUG : Working with test: kraken 11:33:11 INFO - 2015-12-17 11:33:11,655 DEBUG : Generating results file: kraken 11:33:11 INFO - 2015-12-17 11:33:11,655 INFO : javascript benchmark 11:33:11 INFO - 2015-12-17 11:33:11,656 DEBUG : Working with test: v8_7 11:33:11 INFO - 2015-12-17 11:33:11,656 DEBUG : Generating results file: v8_7 11:33:11 INFO - 2015-12-17 11:33:11,656 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:33:11 INFO - 2015-12-17 11:33:11,710 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,53,35]] 11:33:11 INFO - 2015-12-17 11:33:11,710 DEBUG : process_Request line: dromaeo_css 7298.69 graph.html#tests=[[72,53,35]] 11:33:11 INFO - 2015-12-17 11:33:11,710 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:33:11 INFO - 2015-12-17 11:33:11,746 DEBUG : process_Request line: kraken 1460.80 graph.html#tests=[[232,53,35]] 11:33:11 INFO - 2015-12-17 11:33:11,746 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:33:11 INFO - 2015-12-17 11:33:11,787 DEBUG : process_Request line: v8_7 23342.28 graph.html#tests=[[230,53,35]] 11:33:11 INFO - 2015-12-17 11:33:11,788 INFO : javascript benchmark 11:33:11 INFO - 2015-12-17 11:33:11,792 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3399.3031428557147, 3412.692857642813, 3426.7087297579706, 3441.604215515215, 3473.947890781638, 5706.3722990471015, 5713.571482138841, 5746.425357464252, 5751.971240143798, 5759.020966435705, 5706.65760054397, 5711.914321285174, 5752.5110365618975, 5756.194132821408, 5758.193852860592, 5117.590592752589, 5234.293370394986, 5247.370315562138, 5308.389535203443, 5329.973350133244, 5222.399424066243, 5222.529972302492, 5232.29364035856, 5256.737163141846, 5320.122179840322, 5331.120365139747, 5349.5720342372515, 5364.865878353053, 5366.973165134169, 5370.301860758096, 5277.894442111175, 5280.630355875091, 5339.038972984861, 5351.277577527062, 5375.784968601251, 5078.7968481260705, 5105.489451054865, 5152.819651312186, 5158.148905430637, 5175.171972484384, 5488.451154884519, 5489.204065410533, 5492.862678433031, 5511.889762204773, 5516.641418307797, 5815.941840581582, 6127.969360153215, 6145.877082458371, 6147.846303842395, 6164.753409863645, 6009.308929473123, 6124.846878828021, 6246.687665616746, 6249.218847644044, 6267.091271765614, 5795.246617939683, 5809.88380232393, 5810.0, 5812.070068788974, 5846.736896839652, 6020.518358531307, 6118.714631166882, 6290.21372328459, 6317.736452709477, 6322.652254126067, 6022.909656355158, 6101.8474538136015, 6111.188574387999, 6112.505978000999, 6117.234543797379, 6186.443220110212, 6218.440340369298, 6220.688965551704, 6231.283402408691, 6242.531810114259, 5938.524918006549, 6078.149059131725, 6088.939110608837, 6178.814635560941, 6188.412100850412, 6103.511719062553, 6104.481119104926, 6105.725242364104, 6106.45041946227, 6129.662868542184, 4722.905541889212, 4725.362076119749, 4731.716097034189, 4737.431508219036, 4759.50025247351, 4115.403266526337, 4160.271952408377, 4203.264428725022, 4214.536400995888, 4235.915281694349, 5679.659220446786, 5684.0, 5688.317401911714, 5688.516476099578, 5760.51035661965, 6180.752769889244, 6184.288806787277, 6185.288691800411, 6191.876162476725, 6193.473554747807, 5567.2762540870235, 5673.744681489343, 5685.1756495307945, 5771.0, 5771.249737534094, 5348.358197016383, 5354.705491198021, 5389.649672771257, 5391.406945236021, 5392.0294347017125, 6072.36240194782, 6387.073874288295, 6396.488280937514, 6399.200099987502, 6400.903986440114, 6071.423214794588, 6125.601835880653, 6159.353267906985, 6160.229971253593, 6178.320384757583, 6363.61818290904, 6456.451201647913, 6471.546991710723, 6476.579022363531, 6476.870462590816, 5909.5863289569315, 6033.3061697905305, 6157.107219453064, 6197.194364732556, 6200.441960223421, 6047.485963693135, 6151.876962460815, 6155.199824022849, 6159.84600384994, 6162.22972128484, 6039.245094363205, 6118.571699980958, 6120.112583675431, 6120.571559990758, 6121.663308518075, 5802.361740208658, 5924.733386997682, 5984.551158663205, 6060.303065147565, 6099.725512351866, 5971.402859713994, 5982.970085149721, 5990.7903223386975, 5992.161097446274, 6004.039353703386, 6042.305134909541, 6081.239845019372, 6094.725737341919, 6101.0, 6107.511399088151, 5721.628094173865, 5775.989201889569, 5832.504237139721, 5914.083317085859, 5949.8215053548465], "unit": "ms", "name": "dojo.html", "value": 5672.125153295159}, {"lowerIsBetter": false, "replicates": [602.936691647377, 635.6853357587995, 637.0189907542385, 672.1732269308748, 679.2765704524684, 40783.38824917625, 41095.0, 41109.79445102774, 41222.0, 41316.79341603295, 45018.0, 45590.772046139726, 45604.0, 45627.31559026609, 45637.31544026834, 8040.316573091294, 8177.836443271131, 9186.173244408019, 9360.859587106199, 10633.149348052177, 10868.45657717115, 10879.0, 10914.617988370408, 10926.726831829188, 10968.670939871778, 11033.558657653684, 11135.220534562584, 11137.276077055007, 11139.888601113966, 11149.331040137618, 10950.233483656148, 11033.668989930315, 11034.448277586169, 11047.226694131374, 11049.889501104966, 10921.617743379024, 10928.180386471047, 11009.504572294267, 11030.448477576088, 11051.17116216279, 44416.55583444189, 44816.10367792626, 44845.551544484464, 44883.551164488264, 44919.55080449186, 3717.646823551758, 3767.698584113264, 3793.905152371185, 3804.087019115392, 3827.827747751358, 31787.523187152212, 31876.681233187603, 34309.485357719655, 34586.30827383438, 34949.301013979835, 3388.6611338866164, 3406.0463070340097, 3445.3970555152746, 3488.720902327808, 3563.9109022274392, 303878.0, 310946.44526777446, 312146.0, 313274.0, 313408.0, 61874.381256187764, 63320.68339658364, 72344.63827680828, 72740.63629681818, 73119.0, 80291.59854200692, 81060.59469702732, 81313.0, 81374.0, 81386.59306703428, 17626.823731762775, 17654.646907061786, 17757.378491752726, 17804.020778857288, 17849.929004259786, 14754.114753114847, 14945.551633451014, 14955.177465239516, 14965.326560304813, 14967.326470308644, 24510.264692059267, 24799.13203037885, 24891.0, 24906.5018699625, 25020.124295649566, 9340.299477539213, 9486.430814151174, 9549.137918105902, 9693.0, 9835.164011058998, 997.984072174204, 1145.8999360613905, 1155.9017483513828, 1181.8168183931505, 1202.3927916402336, 30711.69288307133, 31415.0, 31582.210444738605, 35411.0, 35746.0, 1103.1175059952006, 1209.407390378708, 1246.0003389120843, 1250.662321173278, 1255.1841303153024, 14669.413223470941, 15818.841811581968, 15877.967932084377, 16138.35446582147, 17260.482185534453, 415071.0, 420064.0, 420656.0, 420944.0, 422344.0, 60996.39003609996, 61617.38382616206, 61622.69188654028, 61645.0, 61673.07490387648, 1426.450816435659, 1479.0312345413772, 1531.379791184572, 1561.375449820081, 1598.3926108078856, 31637.050888473383, 31692.5246121313, 32295.51556726604, 34118.658813411545, 35405.645943540236, 57308.71345643245, 57920.420795791506, 58015.41984580269, 58073.70963145157, 58087.12869306879, 349091.0, 354770.0, 354983.0, 355070.0, 356473.0, 47652.285215722484, 48015.0, 48574.27138592995, 48948.75525622349, 49023.50976490189, 51943.480565193866, 52106.478935210165, 52524.0, 52731.73634131805, 53561.0, 42697.573024270605, 43581.78209109061, 43726.78136609297, 44554.3316850254, 45025.0, 46782.0, 47078.52921470878, 48561.757191213816, 48895.26657100075, 49280.75359623179, 42052.57947420487, 42302.576974231095, 47026.52973470358, 47752.28371574359, 47771.761141194074, 35434.82282588674, 36023.541809577946, 36716.44925326069, 37345.626543734215, 37488.43767343547, 27967.860160699067, 28623.713762862106, 28656.14031579056, 28873.422531548833, 28987.7101228985], "unit": "ms", "name": "ext.html", "value": 21865.392032702126}, {"lowerIsBetter": false, "replicates": [384.455321931789, 388.49883650091385, 390.2390338839264, 390.97263191576593, 394.4083874188717, 13614.727705445885, 14161.575152745434, 18232.361867334646, 20665.99999999998, 20698.586028279424, 13073.803892941614, 13386.799198012037, 13402.128861624013, 19003.714944275813, 20714.378568642966, 4721.527847215269, 4817.879553011186, 4832.033593281358, 4833.081714474256, 4837.4195096588455, 4807.639427042968, 4849.733264670442, 4850.2724591311235, 4852.708837469745, 4854.0, 3826.349520581508, 4428.734275943438, 4810.326554282403, 4814.590759785422, 4816.518348165173, 5126.615503837227, 5154.278401023878, 5169.405518365398, 5177.508136727005, 5191.714455704935, 4461.174682683682, 4560.338750881137, 4564.977175114103, 4574.794134263966, 4577.519360467137, 15340.616484587863, 15749.370025198978, 15765.763513547307, 15788.526344209693, 15835.76246356294, 2207.823374130082, 2262.8076613487874, 2297.0, 2338.181636427254, 2375.786179243876, 10501.789964200749, 11014.0, 11050.226484146113, 11146.777064458747, 11274.210805243554, 1785.1074462768615, 1807.8915265084006, 1855.5546668799525, 1871.9719204211947, 1899.7150427435995, 66664.33335666629, 67063.32936670669, 68013.65993170052, 68384.3161568383, 68675.0, 7624.5425274483705, 7751.844963100706, 7893.526388416713, 7945.324647405036, 7955.24425179607, 9524.666636667684, 9529.761755956019, 9545.952270238744, 9573.760655983517, 9585.041495850359, 6265.122882796412, 6311.652859092702, 6316.2736285326855, 6317.273513546001, 6423.518236132309, 6602.3397660233595, 6713.731450741916, 6722.932770672329, 6733.629650369178, 6734.124563806674, 3640.3265395901844, 3657.835397407123, 3666.6883314917995, 3694.704423646102, 3697.279030589063, 1261.4386597964, 1286.691194113406, 1287.2984223598162, 1290.1291628150962, 1319.736052789446, 417.997910010448, 526.6734624532737, 534.943830897758, 539.2046731071716, 551.0, 13032.674183145307, 13329.133606315558, 13502.054856159975, 13530.45878164882, 13591.932040339734, 528.516407487145, 531.0441205829492, 539.6303532080537, 554.5979165105266, 597.6175247841385, 6599.868002639921, 7306.159791624032, 7347.155077166088, 7414.369778568882, 7464.70141194357, 664663.0, 681517.0, 685139.0, 693095.0, 701156.0, 67039.31283779342, 74792.25207747961, 87654.56172719096, 88627.55686221656, 89335.55332223428, 596.7672607683007, 609.3571282297219, 610.1793088296234, 610.7418717442083, 612.2071916867578, 11728.94135529317, 11968.76062478728, 12200.572979946015, 12288.81566776517, 12321.383930803604, 38772.80613596914, 38919.44322227079, 39184.0, 39806.0, 40128.398074029494, 48554.27168592544, 50761.0, 50986.490135098175, 53006.0, 53522.73238633782, 7431.182569917413, 7588.392928565812, 7594.848103037798, 7655.923440765521, 7674.961625191839, 6307.590006649553, 13531.458741650224, 13824.820291332848, 13890.930545347208, 14127.081739686888, 9636.75908102303, 11910.702232444259, 11952.64142075739, 11959.521619135485, 11994.460249288977, 11051.392173430539, 11256.606018789304, 11660.591879284184, 11695.0, 12005.279683219034, 11591.826122608, 11841.644750657493, 11891.940540297242, 11959.402029898645, 11959.521619135137, 7430.665620047002, 7483.738069167553, 7502.0, 7508.887366689395, 7525.548467091992, 11684.0, 11860.525578976743, 11963.64109076729, 12316.50733970667, 12320.383980800745], "unit": "ms", "name": "jquery.html", "value": 7636.217591070785}, {"lowerIsBetter": false, "replicates": [1563.765435184722, 1569.5448319987197, 1787.195761907142, 1846.639905218482, 1860.3116846766698, 7199.568025918448, 7298.197198308182, 8126.553039582821, 8338.249557539828, 8344.666213351466, 7993.680252789896, 8027.197280271985, 8137.30832879206, 8139.511629302246, 8155.225253600914, 2350.4123969007705, 2419.0565679385054, 2424.490856920049, 2425.575524283252, 2426.3691440225493, 2174.423777698911, 2206.2388475975763, 2465.5315490056923, 2469.1604854349516, 2492.4890397468566, 2426.514697060586, 2427.320350301918, 2429.878506074698, 2452.460458699083, 2455.6439316299125, 2427.4416884116663, 2437.305367970138, 2452.840565363246, 2455.938601534967, 2457.2751038443703, 2430.2466235466886, 2471.023945541519, 2472.851628902272, 2475.2450502596703, 2475.7276699563035, 8192.713255036046, 8224.547649879254, 8244.051934027604, 8248.83502329956, 8295.460795048302, 5057.519535644108, 5108.386993560759, 5118.948810511884, 5125.974370128163, 5133.922991155136, 3338.565986421774, 3341.198112453018, 3472.531208286874, 3495.07380544156, 3505.1762835733584, 1115.5036008976008, 1132.116948779953, 1143.8798926112722, 1146.7649131927935, 1199.5801469485698, 11407.25852819564, 11527.538898444052, 11558.942205289004, 11560.826587601192, 11562.479688414041, 4616.16908956391, 4649.0, 4653.581177694024, 4680.46174689915, 4682.765861706901, 9908.20734341251, 9933.900660993442, 9936.900630993598, 9943.154831839374, 9944.45305508204, 5163.302954101224, 5168.767405466763, 5172.5603323717905, 5176.896462070813, 5178.741062946838, 4692.788824502905, 4692.906141877143, 4697.741624210701, 4698.36572062774, 4703.6942598730975, 3529.770564913272, 3921.11774850662, 3934.370500719871, 3983.143624120828, 3985.900352491211, 1237.3503910446907, 1273.0515765754571, 1275.6491964709778, 1279.36031984008, 1295.9740805183844, 1134.7276653603076, 1396.197186617699, 1449.0219102106037, 1458.2635768936832, 1485.2054151029147, 7957.283844454027, 7984.720534781255, 8010.599470026592, 8059.677612895536, 8067.0, 1157.7742340243572, 1164.185070450671, 1171.4855433698904, 1251.4305990774176, 1252.8935040521658, 6248.062790581358, 6267.091271765568, 6300.30696623371, 6308.621482711052, 6311.936880631227, 10007.199424046059, 10103.949480252699, 10162.949185254027, 10178.0, 10183.18534517237, 9829.754256143653, 10017.649382271586, 10048.447335396477, 10063.04401081896, 10075.3954762713, 7783.922160778433, 7846.136924938366, 7849.293563579306, 7858.764237072897, 7861.52830830152, 7629.923700762922, 7706.730264440942, 7712.807179820549, 7726.42051846125, 7740.41946853977, 8534.445261058012, 8959.641614335615, 8977.551122443982, 9014.549272536478, 9120.908790912272, 8930.955345223232, 9013.639454422011, 9104.772380690536, 9346.906530934604, 9348.20540254086, 8031.437799353989, 8090.231428014329, 8163.0, 8167.264946154874, 8169.673213071411, 7259.165196002527, 7335.706571737284, 8121.553314567519, 8173.305269052197, 8185.672573097009, 7641.7707468776025, 7650.387968962581, 7703.114141873756, 7817.413693972861, 7834.0599128105, 7472.551646901204, 7638.656260468403, 7642.350400216044, 7760.45676802641, 7785.493942893921, 7693.115291741297, 7716.228377162239, 7730.536167829948, 7879.212078792075, 7890.408219383455, 7226.313500217471, 7267.091613548307, 7312.634368281671, 7313.451491138292, 7315.926840731525, 7076.787696369117, 7126.608036557832, 7132.215456299907, 7311.780646580611, 7322.3775979042375], "unit": "ms", "name": "mootools.html", "value": 4883.700946055636}, {"lowerIsBetter": false, "replicates": [343.5962743776063, 354.70736642270134, 363.38587786640574, 364.6608653951827, 369.0717844620779, 5861.267341582302, 5956.106584012389, 6004.819855404339, 6008.909866352003, 6017.939820601792, 5779.133130030497, 5897.380775018625, 5909.349971503142, 5909.85225369366, 5917.704114794265, 4622.653301002439, 4632.351470794091, 4640.327152562885, 4643.187442197619, 4643.837465688702, 4428.357888106223, 4491.191585514606, 4558.680892337537, 4633.142868569325, 4643.721376717391, 4578.969731810349, 4592.15045216636, 4598.816047358102, 4602.700824446417, 4604.562566556172, 4585.037142200142, 4592.6555508337005, 4593.173228818828, 4593.862184134481, 4604.056168485453, 4050.797460126982, 4052.858149964737, 4057.898552536181, 4058.0463591056077, 4064.4309796628495, 5575.418106701594, 5654.9151762723595, 5687.601867869251, 5724.9427505724825, 5726.226959360475, 5395.865103372447, 5400.324959380077, 5407.810726624549, 5411.431799661018, 5413.485718856702, 6037.849053773647, 6349.111124442582, 6357.014662727284, 6357.809265722036, 6359.20509936258, 4362.629176519999, 4465.68740188187, 4516.796744146522, 4522.253828118356, 4532.592066713979, 6457.80626581208, 6461.160049193575, 6470.708818103197, 6491.578047426902, 6497.447716944065, 4626.329182268552, 4627.467841198305, 4628.791704373311, 4629.768511574475, 4630.0, 4528.071745292207, 4594.851287178206, 4634.97682511592, 4691.132140554008, 4695.201815691341, 5268.552173065333, 5291.232771248225, 5291.550218231417, 5292.047431462297, 5292.788288468418, 6289.40250676185, 6296.370362963758, 6309.1167236586, 6327.96836015817, 6331.873362532723, 1644.8519633232827, 1656.3540219314477, 1657.1382880901863, 1657.709900767385, 1658.6268089679968, 1104.2601457023814, 1115.16919894679, 1120.3781901045, 1127.3236058364917, 1141.6175581180398, 6090.33006369299, 6113.0, 6125.264968203844, 6125.908111378333, 6131.693415329305, 6469.256035555877, 6474.287828338879, 6526.184226971629, 6528.608283503005, 6536.8365790855605, 5985.34161242263, 6093.695315234309, 6103.023516237381, 6104.236970378703, 6108.0, 3595.442706380515, 3624.8006359649944, 3627.165751877083, 3627.3108109459645, 3628.6552777486095, 6735.326467353226, 6745.494087943423, 6745.966270168716, 6746.494012949049, 6747.730090796412, 6629.46964242869, 6711.127553418024, 6719.395254427027, 6729.6971636276485, 6729.764458243938, 6723.260441351447, 6752.155980502437, 6758.83102922421, 6763.526553141233, 6766.086578311963, 6318.62088274705, 6411.230652321751, 6441.066045423481, 6532.542722009413, 6538.705758240986, 6430.3891130342545, 6445.162128923397, 6466.741330346922, 6474.773382931575, 6476.352364763675, 6669.866602667822, 6689.130413046273, 6702.229243637044, 6704.631245281556, 6711.664416779044, 4472.105578884171, 4582.19811532987, 4582.335561343653, 4587.839425620087, 4611.123886461562, 6516.837079072871, 6630.204375474974, 6634.701438435379, 6642.90035649456, 6646.501512386687, 6443.259025212161, 6451.48388128958, 6453.9354606453335, 6455.9677201613695, 6466.224053113657, 6343.143675603735, 6456.7740129095255, 6461.06314584392, 6462.870742585028, 6467.191601049869, 6310.337414571588, 6313.337099604475, 6314.494840412848, 6317.684115794284, 6359.141515895295, 6453.870922581616, 6456.935430645822, 6458.773942912164, 6464.0, 6485.027245912962, 6156.5998210116195, 6262.812115636538, 6285.308616052139, 6302.243730752339, 6324.114623952558], "unit": "ms", "name": "prototype.html", "value": 4826.18187470637}, {"lowerIsBetter": false, "replicates": [896.0367604824813, 897.4077109107988, 934.0705997532456, 934.2852717670978, 972.2222222222225, 15256.160911149882, 16500.917495412537, 16506.17469126542, 16507.75238371424, 16515.33938642453, 15142.394304227817, 15196.240187990585, 15214.163221022867, 15222.391104355813, 15236.466723664675, 790.6876783670447, 793.9801504962364, 921.9585118669676, 933.3793027636614, 955.3360414511917, 926.7266156483853, 929.0894922975488, 934.9392289501195, 935.9812803743921, 936.4240991790068, 810.8580998325299, 992.8113658404916, 1008.0, 1009.167436864586, 1010.090918173646, 813.446856137826, 959.8128364968799, 977.296346630425, 978.4618459847092, 979.0160888307277, 721.700494294867, 724.782565230434, 725.5356571794056, 726.6766289001397, 727.8798998165296, 13480.0, 13538.0, 13541.864581354257, 13554.59336219915, 13574.049816512848, 13821.378037988316, 13848.653783655389, 13957.162570245819, 13974.58076257714, 14153.080049796834, 10179.949100254526, 10511.369317840954, 10531.578736850517, 10532.42071686057, 10648.467576621215, 3509.596396414394, 3548.0420286522494, 3554.644535546425, 3555.6088830228655, 3559.75081744278, 53860.46139538594, 53907.46092539064, 54003.72998134984, 54263.0, 55608.0, 8179.795505112301, 8224.259816616533, 8244.134365891496, 8283.544405057659, 11012.284201526874, 14313.928430357782, 14421.855781442051, 14447.422103115758, 14458.638534036732, 14470.059446135967, 7676.19399963007, 7830.569318687527, 7832.334251588565, 7846.803829904298, 7914.287714105758, 4484.349769283435, 4565.771711414416, 4575.748333841604, 4588.908221835544, 4602.332661764092, 3174.761892858045, 3185.155933677577, 3196.744260459158, 3199.2481766784786, 3202.439573074703, 473.5808809203879, 479.92321228603254, 481.4727872979082, 485.7110019538369, 498.3894728957071, 706.3925024478943, 712.9911772320798, 720.8486217894301, 738.471992525347, 747.8952946587482, 9208.26333893287, 9489.0, 9513.286503512265, 9584.472853993097, 9627.229821614254, 571.8893621652654, 662.718344703499, 667.2126890269432, 676.7800464848943, 769.5190505933791, 4656.511066338054, 4755.001449695534, 4773.832915847998, 4818.253170758538, 4819.180739274332, 66576.33423665701, 66686.33313666898, 66719.0, 66874.33125668681, 66993.66503167454, 54448.72775636175, 55256.72371638116, 55341.44658553443, 55749.72125139349, 56435.0, 53861.46138538643, 54150.18774718382, 55147.44852551423, 55492.44507554873, 55918.440815592134, 9358.672446464341, 9381.0, 9389.953050234704, 9622.759431014281, 9709.757256068655, 40932.795336023126, 41169.79415103025, 41218.79390603028, 42001.159976800904, 42042.0, 49419.50580494149, 53834.730826347186, 53847.46152538424, 54307.18539221836, 54466.45533544614, 8453.704120355758, 8586.0, 9088.318376121684, 9120.851783670987, 9123.0, 13088.869111308764, 13146.935164846132, 13361.933190333986, 13378.13042152257, 13644.044916856123, 12750.42623081945, 12811.679708007374, 12818.230906145662, 12986.545470908473, 13222.669433264246, 11631.6510504685, 11637.359945202756, 11696.239744416585, 11750.70623234426, 12032.217905836093, 12586.370681466073, 12617.558385456465, 12703.491860325483, 13041.804372934224, 13296.468141274241, 10190.286679932333, 10771.784564308826, 10797.73005674833, 10890.782184356427, 11393.462180863795, 10303.896961030294, 10343.741406464898, 10344.586216551254, 10371.94814025925, 10463.633772817915], "unit": "ms", "name": "yui.html", "value": 6771.685647785543}], "name": "dromaeo_css", "value": 7298.692008918}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 110.0, 104.0, 110.0, 112.0, 111.0, 101.0, 110.0, 105.0, 109.0], "unit": "ms", "name": "ai-astar", "value": 108.1}, {"lowerIsBetter": true, "replicates": [148.0, 120.0, 146.0, 157.0, 123.0, 156.0, 148.0, 123.0, 170.0, 123.0], "unit": "ms", "name": "audio-beat-detection", "value": 141.4}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 159.0, 160.0, 160.0, 159.0, 158.0, 164.0, 160.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 160.2}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 72.0, 147.0, 72.0, 71.0, 70.0, 71.0, 155.0, 82.0], "unit": "ms", "name": "audio-fft", "value": 88.4}, {"lowerIsBetter": true, "replicates": [90.0, 88.0, 145.0, 93.0, 90.0, 90.0, 128.0, 88.0, 89.0, 134.0], "unit": "ms", "name": "audio-oscillator", "value": 103.5}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 146.0, 145.0, 146.0, 145.0, 146.0, 145.0, 145.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.4}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [54.0, 55.0, 54.0, 54.0, 55.0, 55.0, 57.0, 64.0, 53.0, 53.0], "unit": "ms", "name": "json-parse-financial", "value": 55.4}, {"lowerIsBetter": true, "replicates": [63.0, 65.0, 64.0, 64.0, 63.0, 64.0, 64.0, 63.0, 63.0, 63.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 63.6}, {"lowerIsBetter": true, "replicates": [78.0, 79.0, 77.0, 80.0, 80.0, 85.0, 80.0, 79.0, 78.0, 79.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 79.5}, {"lowerIsBetter": true, "replicates": [108.0, 115.0, 112.0, 109.0, 110.0, 111.0, 110.0, 109.0, 119.0, 122.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 112.5}, {"lowerIsBetter": true, "replicates": [138.0, 129.0, 135.0, 134.0, 135.0, 134.0, 136.0, 135.0, 146.0, 126.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 134.8}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 64.0, 62.0, 65.0, 61.0, 62.0, 63.0, 63.0, 64.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 63.1}], "name": "kraken", "value": 1460.7999999999997}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [163.371998039536], "unit": "score", "name": "Richards", "value": 216.08354200000005}, {"lowerIsBetter": false, "replicates": [171.32088401576152], "unit": "score", "name": "DeltaBlue", "value": 385.93076599999995}, {"lowerIsBetter": false, "replicates": [279.3296089385475], "unit": "score", "name": "Encrypt", "value": 952.9279799999998}, {"lowerIsBetter": false, "replicates": [5000.0], "unit": "score", "name": "Decrypt", "value": 53.23619999999997}, {"lowerIsBetter": false, "replicates": [939.8496240601504], "unit": "score", "name": "RayTrace", "value": 787.3482960000001}, {"lowerIsBetter": false, "replicates": [551.8763796909492], "unit": "score", "name": "Earley", "value": 1207.6309559999997}, {"lowerIsBetter": false, "replicates": [10479.166666666666], "unit": "score", "name": "Boyer", "value": 63.59885487077532}, {"lowerIsBetter": false, "replicates": [23904.761904761905], "unit": "score", "name": "RegExp", "value": 38.10893426294821}, {"lowerIsBetter": false, "replicates": [529.6296296296297], "unit": "score", "name": "Splay", "value": 153.86412587412593}, {"lowerIsBetter": false, "replicates": [4812.5], "unit": "score", "name": "NavierStokes", "value": 308.3636363636364}], "name": "v8_7", "value": 23342.275954411467}]} 11:33:11 INFO - RETURN: dromaeo_css: 7298.69 11:33:11 INFO - RETURN: kraken: 1460.80 11:33:11 INFO - RETURN: v8_7: 23342.28 11:33:11 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,53,35]]", "result": "23342.28"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,53,35]]", "result": "1460.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,53,35]]", "result": "7298.69"}}} 11:33:11 INFO - Return code: 0 11:33:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 11:33:11 INFO - # TBPL SUCCESS # 11:33:11 INFO - Running post-action listener: _resource_record_post_action 11:33:11 INFO - Running post-run listener: _resource_record_post_run 11:33:12 INFO - Total resource usage - Wall time: 1221s; CPU: 13.0%; Read bytes: 315392; Write bytes: 276688896; Read time: 64; Write time: 176812 11:33:12 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 19492864; Read time: 0; Write time: 3220 11:33:12 INFO - run-tests - Wall time: 1207s; CPU: 13.0%; Read bytes: 315392; Write bytes: 257196032; Read time: 64; Write time: 173592 11:33:12 INFO - Running post-run listener: _upload_blobber_files 11:33:12 INFO - Blob upload gear active. 11:33:12 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 11:33:12 INFO - Copying logs to upload dir... 11:33:12 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1292.307830 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 32 secs) (at 2015-12-17 11:33:11.800142) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-17 11:33:11.803536) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test-pgo/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e10134013339c31d8d0c4708000001d6-1450376188.393086-729757505 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450371150/firefox-44.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009935 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450371150/firefox-44.0.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-17 11:33:11.855096) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 11:33:11.855428) ========= rm -f oauth.txt in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e10134013339c31d8d0c4708000001d6-1450376188.393086-729757505 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004568 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 11:33:11.904735) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-17 11:33:11.905063) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-17 11:33:11.905361) ========= ========= Total master_lag: 0.27 =========