builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-014 starttime: 1453155852.48 results: success (0) buildid: 20160118120031 builduid: 818fd5d38f994d05b8cc299dc07eda1c revision: f84fcce02b11 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-18 14:24:12.477457) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-18 14:24:12.477883) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-18 14:24:12.478197) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1453155511.984397-1926919890 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006367 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-18 14:24:12.510704) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-18 14:24:12.511006) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-18 14:24:12.539910) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 14:24:12.540199) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1453155511.984397-1926919890 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004633 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 14:24:12.591989) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-18 14:24:12.592286) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-18 14:24:12.592665) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 14:24:12.592977) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1453155511.984397-1926919890 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-18 14:24:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2016-01-18 14:24:13 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.186925 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 14:24:12.795682) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 14:24:12.796390) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1453155511.984397-1926919890 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017885 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 14:24:12.850120) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 14:24:12.850917) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev f84fcce02b11 --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 f84fcce02b11 --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=fa9c93d544b966bd2b8d485a000001c6-1453155511.984397-1926919890 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-18 14:24:13,483 Setting DEBUG logging. 2016-01-18 14:24:13,483 attempt 1/10 2016-01-18 14:24:13,483 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/f84fcce02b11?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-18 14:24:13,763 unpacking tar archive at: mozilla-beta-f84fcce02b11/testing/mozharness/ program finished with exit code 0 elapsedTime=0.613665 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 14:24:13.480344) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-18 14:24:13.480838) ========= echo '%(revision)s' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', '%(revision)s'] 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=fa9c93d544b966bd2b8d485a000001c6-1453155511.984397-1926919890 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False %(revision)s program finished with exit code 0 elapsedTime=0.004578 script_repo_revision: '%(revision)s' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-18 14:24:13.534773) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-18 14:24:13.535100) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-18 14:24:13.545126) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-18 14:24:13.545804) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/%(revision)s ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-18 14:24:13.546729) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-01-18 14:24:13.547408) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fa9c93d544b966bd2b8d485a000001c6-1453155511.984397-1926919890 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:24:14 INFO - MultiFileLogger online at 20160118 14:24:14 in /builds/slave/test-pgo 14:24:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 14:24:14 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 14:24:14 INFO - {'append_to_log': False, 14:24:14 INFO - 'base_work_dir': '/builds/slave/test-pgo', 14:24:14 INFO - 'blob_upload_branch': 'Mozilla-Beta', 14:24:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 14:24:14 INFO - 'branch': 'Mozilla-Beta', 14:24:14 INFO - 'buildbot_json_path': 'buildprops.json', 14:24:14 INFO - 'config_files': ('talos/linux_config.py',), 14:24:14 INFO - 'default_actions': ('clobber', 14:24:14 INFO - 'read-buildbot-config', 14:24:14 INFO - 'download-and-extract', 14:24:14 INFO - 'populate-webroot', 14:24:14 INFO - 'create-virtualenv', 14:24:14 INFO - 'install', 14:24:14 INFO - 'run-tests'), 14:24:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:24:14 INFO - 'download_minidump_stackwalk': True, 14:24:14 INFO - 'download_symbols': 'ondemand', 14:24:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:24:14 INFO - 'tooltool.py': '/tools/tooltool.py', 14:24:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:24:14 INFO - '/tools/misc-python/virtualenv.py')}, 14:24:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:24:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:24:14 INFO - 'installer_path': 'installer.exe', 14:24:14 INFO - 'log_level': 'info', 14:24:14 INFO - 'log_name': 'talos', 14:24:14 INFO - 'log_to_console': True, 14:24:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:24:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:24:14 INFO - 'opt_config_files': (), 14:24:14 INFO - 'pip_index': False, 14:24:14 INFO - 'sps_profile': False, 14:24:14 INFO - 'sps_profile_interval': 0, 14:24:14 INFO - 'suite': 'dromaeojs', 14:24:14 INFO - 'system_bits': '32', 14:24:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:24:14 INFO - 'title': 'talos-linux64-ix-014', 14:24:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:24:14 INFO - 'use_talos_json': True, 14:24:14 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 14:24:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:24:14 INFO - 'work_dir': 'build'} 14:24:14 INFO - ##### 14:24:14 INFO - ##### Running clobber step. 14:24:14 INFO - ##### 14:24:14 INFO - Running pre-action listener: _resource_record_pre_action 14:24:14 INFO - Running main action method: clobber 14:24:14 INFO - rmtree: /builds/slave/test-pgo/build 14:24:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 14:24:15 INFO - Running post-action listener: _resource_record_post_action 14:24:15 INFO - ##### 14:24:15 INFO - ##### Running read-buildbot-config step. 14:24:15 INFO - ##### 14:24:15 INFO - Running pre-action listener: _resource_record_pre_action 14:24:15 INFO - Running main action method: read_buildbot_config 14:24:15 INFO - Using buildbot properties: 14:24:15 INFO - { 14:24:15 INFO - "properties": { 14:24:15 INFO - "buildnumber": 80, 14:24:15 INFO - "product": "firefox", 14:24:15 INFO - "script_repo_revision": "production", 14:24:15 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 14:24:15 INFO - "repository": "", 14:24:15 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 14:24:15 INFO - "buildid": "20160118120031", 14:24:15 INFO - "slavename": "talos-linux64-ix-014", 14:24:15 INFO - "pgo_build": "True", 14:24:15 INFO - "basedir": "/builds/slave/test-pgo", 14:24:15 INFO - "project": "", 14:24:15 INFO - "platform": "ubuntu64_hw", 14:24:15 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:24:15 INFO - "slavebuilddir": "test", 14:24:15 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 14:24:15 INFO - "branch": "mozilla-beta", 14:24:15 INFO - "repo_path": "releases/mozilla-beta", 14:24:15 INFO - "stage_platform": "linux64-pgo", 14:24:15 INFO - "builduid": "818fd5d38f994d05b8cc299dc07eda1c", 14:24:15 INFO - "revision": "f84fcce02b11" 14:24:15 INFO - }, 14:24:15 INFO - "sourcestamp": { 14:24:15 INFO - "repository": "", 14:24:15 INFO - "hasPatch": false, 14:24:15 INFO - "project": "", 14:24:15 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 14:24:15 INFO - "changes": [ 14:24:15 INFO - { 14:24:15 INFO - "category": null, 14:24:15 INFO - "files": [ 14:24:15 INFO - { 14:24:15 INFO - "url": null, 14:24:15 INFO - "name": "http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453147231/firefox-44.0.en-US.linux-x86_64.tar.bz2" 14:24:15 INFO - } 14:24:15 INFO - ], 14:24:15 INFO - "repository": "", 14:24:15 INFO - "rev": "f84fcce02b11", 14:24:15 INFO - "who": "sendchange", 14:24:15 INFO - "when": 1453155801, 14:24:15 INFO - "number": 7475630, 14:24:15 INFO - "comments": "Bug 1233982 - Do not fetch autofill icons from the network. r=adw a=ritu CLOSED TREE", 14:24:15 INFO - "project": "", 14:24:15 INFO - "at": "Mon 18 Jan 2016 14:23:21", 14:24:15 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 14:24:15 INFO - "revlink": "", 14:24:15 INFO - "properties": [ 14:24:15 INFO - [ 14:24:15 INFO - "buildid", 14:24:15 INFO - "20160118120031", 14:24:15 INFO - "Change" 14:24:15 INFO - ], 14:24:15 INFO - [ 14:24:15 INFO - "builduid", 14:24:15 INFO - "818fd5d38f994d05b8cc299dc07eda1c", 14:24:15 INFO - "Change" 14:24:15 INFO - ], 14:24:15 INFO - [ 14:24:15 INFO - "pgo_build", 14:24:15 INFO - "True", 14:24:15 INFO - "Change" 14:24:15 INFO - ] 14:24:15 INFO - ], 14:24:15 INFO - "revision": "f84fcce02b11" 14:24:15 INFO - } 14:24:15 INFO - ], 14:24:15 INFO - "revision": "f84fcce02b11" 14:24:15 INFO - } 14:24:15 INFO - } 14:24:15 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453147231/firefox-44.0.en-US.linux-x86_64.tar.bz2. 14:24:15 INFO - Running post-action listener: _resource_record_post_action 14:24:15 INFO - ##### 14:24:15 INFO - ##### Running download-and-extract step. 14:24:15 INFO - ##### 14:24:15 INFO - Running pre-action listener: _resource_record_pre_action 14:24:15 INFO - Running main action method: download_and_extract 14:24:15 INFO - mkdir: /builds/slave/test-pgo/build/tests 14:24:15 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')]} 14:24:15 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453147231/test_packages.json 14:24:15 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453147231/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 14:24:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453147231/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 14:24:15 INFO - Downloaded 1270 bytes. 14:24:15 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 14:24:15 INFO - Using the following test package requirements: 14:24:15 INFO - {u'common': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip'], 14:24:15 INFO - u'cppunittest': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 14:24:15 INFO - u'firefox-44.0.en-US.linux-x86_64.cppunittest.tests.zip'], 14:24:15 INFO - u'jittest': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 14:24:15 INFO - u'jsshell-linux-x86_64.zip'], 14:24:15 INFO - u'mochitest': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 14:24:15 INFO - u'firefox-44.0.en-US.linux-x86_64.mochitest.tests.zip'], 14:24:15 INFO - u'mozbase': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip'], 14:24:15 INFO - u'reftest': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 14:24:15 INFO - u'firefox-44.0.en-US.linux-x86_64.reftest.tests.zip'], 14:24:15 INFO - u'talos': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 14:24:15 INFO - u'firefox-44.0.en-US.linux-x86_64.talos.tests.zip'], 14:24:15 INFO - u'web-platform': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 14:24:15 INFO - u'firefox-44.0.en-US.linux-x86_64.web-platform.tests.zip'], 14:24:15 INFO - u'webapprt': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip'], 14:24:15 INFO - u'xpcshell': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 14:24:15 INFO - u'firefox-44.0.en-US.linux-x86_64.xpcshell.tests.zip']} 14:24:15 INFO - Downloading packages: [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:24:15 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')]} 14:24:15 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453147231/firefox-44.0.en-US.linux-x86_64.common.tests.zip 14:24:15 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453147231/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 14:24:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453147231/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 14:24:16 INFO - Downloaded 22573307 bytes. 14:24:16 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 14:24:16 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip 14:24:16 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 14:24:18 INFO - Return code: 0 14:24:18 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 14:24:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:24:18 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453147231/firefox-44.0.en-US.linux-x86_64.common.tests.zip 14:24:18 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453147231/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 14:24:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453147231/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 14:24:19 INFO - Downloaded 22573307 bytes. 14:24:19 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 14:24:19 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip 14:24:19 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 14:24:21 INFO - Return code: 0 14:24:21 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')]} 14:24:21 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453147231/firefox-44.0.en-US.linux-x86_64.talos.tests.zip 14:24:21 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453147231/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 14:24:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453147231/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 14:24:22 INFO - Downloaded 11131970 bytes. 14:24:22 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 14:24:22 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.talos.tests.zip 14:24:22 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 14:24:22 INFO - Return code: 0 14:24:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:24:22 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453147231/firefox-44.0.en-US.linux-x86_64.tar.bz2 14:24:22 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453147231/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 14:24:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453147231/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 14:24:25 INFO - Downloaded 56626174 bytes. 14:24:25 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453147231/firefox-44.0.en-US.linux-x86_64.tar.bz2 14:24:25 INFO - mkdir: /builds/slave/test-pgo/properties 14:24:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 14:24:25 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 14:24:25 INFO - Contents: 14:24:25 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453147231/firefox-44.0.en-US.linux-x86_64.tar.bz2 14:24:25 INFO - Running post-action listener: _resource_record_post_action 14:24:25 INFO - Running post-action listener: set_extra_try_arguments 14:24:25 INFO - ##### 14:24:25 INFO - ##### Running populate-webroot step. 14:24:25 INFO - ##### 14:24:25 INFO - Running pre-action listener: _resource_record_pre_action 14:24:25 INFO - Running main action method: populate_webroot 14:24:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:24:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:24:25 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 14:24:25 INFO - '../fennec_ids.txt'], 14:24:25 INFO - 'tests': ['tcheck2']}, 14:24:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:24:25 INFO - '--tppagecycles', 14:24:25 INFO - '7'], 14:24:25 INFO - 'tests': ['tsvgm']}}, 14:24:25 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:24:25 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:24:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:24:25 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:24:25 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:24:25 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:24:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:24:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:24:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:24:25 INFO - 'talos_options': ['--e10s'], 14:24:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:24:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:24:25 INFO - 'tests': ['damp', 'tps']}, 14:24:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:24:25 INFO - 'talos_options': ['--e10s'], 14:24:25 INFO - 'tests': ['damp', 'tps']}, 14:24:25 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:24:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:24:25 INFO - 'other': {'tests': ['a11yr', 14:24:25 INFO - 'ts_paint', 14:24:25 INFO - 'tpaint', 14:24:25 INFO - 'sessionrestore', 14:24:25 INFO - 'sessionrestore_no_auto_restore']}, 14:24:25 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:24:25 INFO - 'tests': ['a11yr', 14:24:25 INFO - 'ts_paint', 14:24:25 INFO - 'tpaint', 14:24:25 INFO - 'sessionrestore', 14:24:25 INFO - 'sessionrestore_no_auto_restore']}, 14:24:25 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:24:25 INFO - 'tests': ['a11yr', 14:24:25 INFO - 'ts_paint', 14:24:25 INFO - 'tpaint', 14:24:25 INFO - 'sessionrestore', 14:24:25 INFO - 'sessionrestore_no_auto_restore']}, 14:24:25 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:24:25 INFO - 'tests': ['a11yr', 14:24:25 INFO - 'ts_paint', 14:24:25 INFO - 'tpaint', 14:24:25 INFO - 'sessionrestore', 14:24:25 INFO - 'sessionrestore_no_auto_restore']}, 14:24:25 INFO - 'other_l64': {'tests': ['a11yr', 14:24:25 INFO - 'ts_paint', 14:24:25 INFO - 'tpaint', 14:24:25 INFO - 'sessionrestore', 14:24:25 INFO - 'sessionrestore_no_auto_restore']}, 14:24:25 INFO - 'other_nol64': {'tests': ['a11yr', 14:24:25 INFO - 'ts_paint', 14:24:25 INFO - 'tpaint', 14:24:25 INFO - 'sessionrestore', 14:24:25 INFO - 'sessionrestore_no_auto_restore']}, 14:24:25 INFO - 'svgr': {'tests': ['tsvgx', 14:24:25 INFO - 'tsvgr_opacity', 14:24:25 INFO - 'tart', 14:24:25 INFO - 'tscrollx', 14:24:25 INFO - 'cart']}, 14:24:25 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:24:25 INFO - 'tests': ['tsvgx', 14:24:25 INFO - 'tsvgr_opacity', 14:24:25 INFO - 'tart', 14:24:25 INFO - 'tscrollx', 14:24:25 INFO - 'cart']}, 14:24:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:24:25 INFO - 'tests': ['tp5o']}, 14:24:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:24:25 INFO - 'talos_options': ['--e10s'], 14:24:25 INFO - 'tests': ['tp5o']}, 14:24:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:24:25 INFO - 'talos_options': ['--xperf_path', 14:24:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:24:25 INFO - 'tests': ['tp5n']}, 14:24:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:24:25 INFO - 'talos_options': ['--e10s', 14:24:25 INFO - '--xperf_path', 14:24:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:24:25 INFO - 'tests': ['tp5n']}}, 14:24:25 INFO - 'talos.zip': {'path': '', 14:24:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:24:25 INFO - Running post-action listener: _resource_record_post_action 14:24:25 INFO - ##### 14:24:25 INFO - ##### Running create-virtualenv step. 14:24:25 INFO - ##### 14:24:25 INFO - Running pre-action listener: _resource_record_pre_action 14:24:25 INFO - Running main action method: create_virtualenv 14:24:25 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 14:24:25 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 14:24:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 14:24:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:24:25 INFO - Using real prefix '/usr' 14:24:25 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 14:24:26 INFO - Installing distribute.............................................................................................................................................................................................done. 14:24:28 INFO - Installing pip.................done. 14:24:28 INFO - Return code: 0 14:24:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 14:24:28 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')]} 14:24:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:28 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')]} 14:24:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:28 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 0x7ff8c6d98f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x206d600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fc350>, '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 0x20fd250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20fd6e0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1453155511.984397-1926919890', '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 14:24:28 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 14:24:28 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 14:24:28 INFO - Using env: {'DISPLAY': ':0', 14:24:28 INFO - 'HOME': '/home/cltbld', 14:24:28 INFO - 'LANG': 'en_US.UTF-8', 14:24:28 INFO - 'LANGUAGE': 'en_US:en', 14:24:28 INFO - 'LOGNAME': 'cltbld', 14:24:28 INFO - 'MAIL': '/var/mail/cltbld', 14:24:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:28 INFO - 'MOZ_NO_REMOTE': '1', 14:24:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:24:28 INFO - 'NO_EM_RESTART': '1', 14:24:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:24:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:24:28 INFO - 'PWD': '/builds/slave/test-pgo', 14:24:28 INFO - 'SHELL': '/bin/bash', 14:24:28 INFO - 'SHLVL': '1', 14:24:28 INFO - 'TERM': 'linux', 14:24:28 INFO - 'TMOUT': '86400', 14:24:28 INFO - 'USER': 'cltbld', 14:24:28 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1453155511.984397-1926919890', 14:24:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:28 INFO - '_': '/tools/buildbot/bin/python'} 14:24:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:28 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 14:24:28 INFO - Cleaning up... 14:24:28 INFO - Return code: 0 14:24:28 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 14:24:28 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')]} 14:24:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:28 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')]} 14:24:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:28 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 0x7ff8c6d98f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x206d600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fc350>, '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 0x20fd250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20fd6e0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1453155511.984397-1926919890', '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 14:24:28 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 14:24:28 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 14:24:28 INFO - Using env: {'DISPLAY': ':0', 14:24:28 INFO - 'HOME': '/home/cltbld', 14:24:28 INFO - 'LANG': 'en_US.UTF-8', 14:24:28 INFO - 'LANGUAGE': 'en_US:en', 14:24:28 INFO - 'LOGNAME': 'cltbld', 14:24:28 INFO - 'MAIL': '/var/mail/cltbld', 14:24:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:28 INFO - 'MOZ_NO_REMOTE': '1', 14:24:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:24:28 INFO - 'NO_EM_RESTART': '1', 14:24:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:24:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:24:28 INFO - 'PWD': '/builds/slave/test-pgo', 14:24:28 INFO - 'SHELL': '/bin/bash', 14:24:28 INFO - 'SHLVL': '1', 14:24:28 INFO - 'TERM': 'linux', 14:24:28 INFO - 'TMOUT': '86400', 14:24:28 INFO - 'USER': 'cltbld', 14:24:28 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1453155511.984397-1926919890', 14:24:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:28 INFO - '_': '/tools/buildbot/bin/python'} 14:24:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:28 INFO - Downloading/unpacking psutil>=0.7.1 14:24:28 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 14:24:28 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 14:24:28 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 14:24:28 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 14:24:28 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 14:24:28 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 14:24:30 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 14:24:30 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 14:24:30 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 14:24:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:24:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:24:30 INFO - Installing collected packages: psutil 14:24:30 INFO - Running setup.py install for psutil 14:24:30 INFO - building 'psutil._psutil_linux' extension 14:24:30 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 14:24:30 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 14:24:30 INFO - building 'psutil._psutil_posix' extension 14:24:30 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 14:24:31 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 14:24:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:24:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:24:31 INFO - Successfully installed psutil 14:24:31 INFO - Cleaning up... 14:24:31 INFO - Return code: 0 14:24:31 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 14:24:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:24:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:24:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:31 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 0x7ff8c6d98f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x206d600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fc350>, '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 0x20fd250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20fd6e0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1453155511.984397-1926919890', '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 14:24:31 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 14:24:31 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 14:24:31 INFO - Using env: {'DISPLAY': ':0', 14:24:31 INFO - 'HOME': '/home/cltbld', 14:24:31 INFO - 'LANG': 'en_US.UTF-8', 14:24:31 INFO - 'LANGUAGE': 'en_US:en', 14:24:31 INFO - 'LOGNAME': 'cltbld', 14:24:31 INFO - 'MAIL': '/var/mail/cltbld', 14:24:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:31 INFO - 'MOZ_NO_REMOTE': '1', 14:24:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:24:31 INFO - 'NO_EM_RESTART': '1', 14:24:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:24:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:24:31 INFO - 'PWD': '/builds/slave/test-pgo', 14:24:31 INFO - 'SHELL': '/bin/bash', 14:24:31 INFO - 'SHLVL': '1', 14:24:31 INFO - 'TERM': 'linux', 14:24:31 INFO - 'TMOUT': '86400', 14:24:31 INFO - 'USER': 'cltbld', 14:24:31 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1453155511.984397-1926919890', 14:24:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:31 INFO - '_': '/tools/buildbot/bin/python'} 14:24:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:31 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:24:31 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 14:24:31 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 14:24:31 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 14:24:31 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 14:24:31 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 14:24:31 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 14:24:33 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:24:33 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 14:24:33 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:24:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:24:33 INFO - Installing collected packages: mozsystemmonitor 14:24:33 INFO - Running setup.py install for mozsystemmonitor 14:24:33 INFO - Successfully installed mozsystemmonitor 14:24:33 INFO - Cleaning up... 14:24:33 INFO - Return code: 0 14:24:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 14:24:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:24:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:24:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:33 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 0x7ff8c6d98f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x206d600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fc350>, '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 0x20fd250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20fd6e0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1453155511.984397-1926919890', '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 14:24:33 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 14:24:33 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 14:24:33 INFO - Using env: {'DISPLAY': ':0', 14:24:33 INFO - 'HOME': '/home/cltbld', 14:24:33 INFO - 'LANG': 'en_US.UTF-8', 14:24:33 INFO - 'LANGUAGE': 'en_US:en', 14:24:33 INFO - 'LOGNAME': 'cltbld', 14:24:33 INFO - 'MAIL': '/var/mail/cltbld', 14:24:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:33 INFO - 'MOZ_NO_REMOTE': '1', 14:24:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:24:33 INFO - 'NO_EM_RESTART': '1', 14:24:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:24:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:24:33 INFO - 'PWD': '/builds/slave/test-pgo', 14:24:33 INFO - 'SHELL': '/bin/bash', 14:24:33 INFO - 'SHLVL': '1', 14:24:33 INFO - 'TERM': 'linux', 14:24:33 INFO - 'TMOUT': '86400', 14:24:33 INFO - 'USER': 'cltbld', 14:24:33 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1453155511.984397-1926919890', 14:24:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:33 INFO - '_': '/tools/buildbot/bin/python'} 14:24:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:33 INFO - Downloading/unpacking blobuploader==1.2.4 14:24:33 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 14:24:33 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 14:24:33 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 14:24:33 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 14:24:33 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 14:24:33 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 14:24:35 INFO - Downloading blobuploader-1.2.4.tar.gz 14:24:35 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 14:24:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:24:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:24:35 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 14:24:35 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 14:24:35 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 14:24:35 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 14:24:35 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 14:24:35 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 14:24:35 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 14:24:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 14:24:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:24:35 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 14:24:35 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 14:24:35 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 14:24:35 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 14:24:35 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 14:24:35 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 14:24:36 INFO - Downloading docopt-0.6.1.tar.gz 14:24:36 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 14:24:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 14:24:36 INFO - Installing collected packages: blobuploader, requests, docopt 14:24:36 INFO - Running setup.py install for blobuploader 14:24:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:24:36 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 14:24:36 INFO - Running setup.py install for requests 14:24:36 INFO - Running setup.py install for docopt 14:24:36 INFO - Successfully installed blobuploader requests docopt 14:24:36 INFO - Cleaning up... 14:24:36 INFO - Return code: 0 14:24:36 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:24:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:24:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:24:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:36 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 0x7ff8c6d98f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x206d600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fc350>, '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 0x20fd250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20fd6e0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1453155511.984397-1926919890', '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 14:24:36 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 14:24:36 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 14:24:36 INFO - Using env: {'DISPLAY': ':0', 14:24:36 INFO - 'HOME': '/home/cltbld', 14:24:36 INFO - 'LANG': 'en_US.UTF-8', 14:24:36 INFO - 'LANGUAGE': 'en_US:en', 14:24:36 INFO - 'LOGNAME': 'cltbld', 14:24:36 INFO - 'MAIL': '/var/mail/cltbld', 14:24:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:36 INFO - 'MOZ_NO_REMOTE': '1', 14:24:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:24:36 INFO - 'NO_EM_RESTART': '1', 14:24:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:24:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:24:36 INFO - 'PWD': '/builds/slave/test-pgo', 14:24:36 INFO - 'SHELL': '/bin/bash', 14:24:36 INFO - 'SHLVL': '1', 14:24:36 INFO - 'TERM': 'linux', 14:24:36 INFO - 'TMOUT': '86400', 14:24:36 INFO - 'USER': 'cltbld', 14:24:36 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1453155511.984397-1926919890', 14:24:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:36 INFO - '_': '/tools/buildbot/bin/python'} 14:24:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:24:36 INFO - Running setup.py (path:/tmp/pip-eL47pU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:24:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:24:37 INFO - Running setup.py (path:/tmp/pip-wIPBMq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:24:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:24:37 INFO - Running setup.py (path:/tmp/pip-3VE6SY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:24:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:24:37 INFO - Running setup.py (path:/tmp/pip-VgPmFs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:24:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 14:24:37 INFO - Running setup.py (path:/tmp/pip-Jhh1n_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 14:24:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:24:37 INFO - Running setup.py (path:/tmp/pip-N2TNlm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:24:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:24:37 INFO - Running setup.py (path:/tmp/pip-RrYafD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:24:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:24:37 INFO - Running setup.py (path:/tmp/pip-q2aL5_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:24:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 14:24:37 INFO - Running setup.py (path:/tmp/pip-861FD8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 14:24:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 14:24:37 INFO - Running setup.py (path:/tmp/pip-ZZeJ7y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 14:24:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:24:37 INFO - Running setup.py (path:/tmp/pip-g2IVXG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:24:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:24:37 INFO - Running setup.py (path:/tmp/pip-hNrvmL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:24:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:24:37 INFO - Running setup.py (path:/tmp/pip-AjGtlU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:24:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:24:37 INFO - Running setup.py (path:/tmp/pip-0Gcdg6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:24:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:24:37 INFO - Running setup.py (path:/tmp/pip-8H75RL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:24:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 14:24:38 INFO - Running setup.py (path:/tmp/pip-GlOCIB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 14:24:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 14:24:38 INFO - Running setup.py (path:/tmp/pip-HQSKwj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 14:24:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:24:38 INFO - Running setup.py install for manifestparser 14:24:38 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 14:24:38 INFO - Running setup.py install for mozcrash 14:24:38 INFO - Running setup.py install for mozdebug 14:24:38 INFO - Running setup.py install for mozdevice 14:24:38 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 14:24:38 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 14:24:38 INFO - Running setup.py install for mozfile 14:24:38 INFO - Running setup.py install for mozhttpd 14:24:38 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 14:24:38 INFO - Running setup.py install for mozinfo 14:24:38 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 14:24:38 INFO - Running setup.py install for mozInstall 14:24:38 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 14:24:38 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 14:24:38 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 14:24:38 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 14:24:38 INFO - Running setup.py install for mozleak 14:24:39 INFO - Running setup.py install for mozlog 14:24:39 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 14:24:39 INFO - Running setup.py install for moznetwork 14:24:39 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 14:24:39 INFO - Running setup.py install for mozprocess 14:24:39 INFO - Running setup.py install for mozprofile 14:24:39 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 14:24:39 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 14:24:39 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 14:24:39 INFO - Running setup.py install for mozrunner 14:24:39 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 14:24:39 INFO - Running setup.py install for mozscreenshot 14:24:39 INFO - Running setup.py install for moztest 14:24:39 INFO - Running setup.py install for mozversion 14:24:39 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 14:24:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:24:39 INFO - Cleaning up... 14:24:39 INFO - Return code: 0 14:24:39 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:24:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:24:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:24:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:39 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 0x7ff8c6d98f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x206d600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fc350>, '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 0x20fd250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20fd6e0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1453155511.984397-1926919890', '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 14:24:39 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 14:24:39 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 14:24:39 INFO - Using env: {'DISPLAY': ':0', 14:24:39 INFO - 'HOME': '/home/cltbld', 14:24:39 INFO - 'LANG': 'en_US.UTF-8', 14:24:39 INFO - 'LANGUAGE': 'en_US:en', 14:24:39 INFO - 'LOGNAME': 'cltbld', 14:24:39 INFO - 'MAIL': '/var/mail/cltbld', 14:24:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:39 INFO - 'MOZ_NO_REMOTE': '1', 14:24:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:24:39 INFO - 'NO_EM_RESTART': '1', 14:24:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:24:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:24:39 INFO - 'PWD': '/builds/slave/test-pgo', 14:24:39 INFO - 'SHELL': '/bin/bash', 14:24:39 INFO - 'SHLVL': '1', 14:24:39 INFO - 'TERM': 'linux', 14:24:39 INFO - 'TMOUT': '86400', 14:24:39 INFO - 'USER': 'cltbld', 14:24:39 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1453155511.984397-1926919890', 14:24:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:39 INFO - '_': '/tools/buildbot/bin/python'} 14:24:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:24:40 INFO - Running setup.py (path:/tmp/pip-CkRGY_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:24:40 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)) 14:24:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:24:40 INFO - Running setup.py (path:/tmp/pip-8HDogw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:24:40 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)) 14:24:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:24:40 INFO - Running setup.py (path:/tmp/pip-8_BvCa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:24:40 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)) 14:24:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:24:40 INFO - Running setup.py (path:/tmp/pip-HtBVkZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:24:40 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)) 14:24:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 14:24:40 INFO - Running setup.py (path:/tmp/pip-TIkQHR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 14:24:40 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)) 14:24:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:24:40 INFO - Running setup.py (path:/tmp/pip-Q9oTBh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:24:40 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)) 14:24:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:24:40 INFO - Running setup.py (path:/tmp/pip-1ZzMlY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:24:40 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)) 14:24:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:24:40 INFO - Running setup.py (path:/tmp/pip-DB9oed-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:24:40 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)) 14:24:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 14:24:40 INFO - Running setup.py (path:/tmp/pip-iEH0VV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 14:24:40 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)) 14:24:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 14:24:40 INFO - Running setup.py (path:/tmp/pip-A5kpKs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 14:24:40 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)) 14:24:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:24:40 INFO - Running setup.py (path:/tmp/pip-ZIU6w7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:24:40 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)) 14:24:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:24:40 INFO - Running setup.py (path:/tmp/pip-Jc7CUd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:24:41 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)) 14:24:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:24:41 INFO - Running setup.py (path:/tmp/pip-s6QCFY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:24:41 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)) 14:24:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:24:41 INFO - Running setup.py (path:/tmp/pip-zDbvw3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:24:41 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)) 14:24:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:24:41 INFO - Running setup.py (path:/tmp/pip-EHJBMv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:24:41 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)) 14:24:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 14:24:41 INFO - Running setup.py (path:/tmp/pip-23QPdd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 14:24:41 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)) 14:24:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 14:24:41 INFO - Running setup.py (path:/tmp/pip-g9bFk5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 14:24:41 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)) 14:24:41 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)) 14:24:41 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)) 14:24:41 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)) 14:24:41 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)) 14:24:41 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)) 14:24:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 14:24:41 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 14:24:41 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 14:24:41 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 14:24:41 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 14:24:41 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 14:24:41 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 14:24:43 INFO - Downloading blessings-1.5.1.tar.gz 14:24:43 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 14:24:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 14:24:43 INFO - Installing collected packages: blessings 14:24:43 INFO - Running setup.py install for blessings 14:24:43 INFO - Successfully installed blessings 14:24:43 INFO - Cleaning up... 14:24:43 INFO - Return code: 0 14:24:43 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 14:24:43 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 14:24:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 14:24:43 INFO - Reading from file tmpfile_stdout 14:24:43 INFO - Current package versions: 14:24:43 INFO - argparse == 1.2.1 14:24:43 INFO - blessings == 1.5.1 14:24:43 INFO - blobuploader == 1.2.4 14:24:43 INFO - docopt == 0.6.1 14:24:43 INFO - manifestparser == 1.1 14:24:43 INFO - mozInstall == 1.12 14:24:43 INFO - mozcrash == 0.16 14:24:43 INFO - mozdebug == 0.1 14:24:43 INFO - mozdevice == 0.46 14:24:43 INFO - mozfile == 1.2 14:24:43 INFO - mozhttpd == 0.7 14:24:43 INFO - mozinfo == 0.8 14:24:43 INFO - mozleak == 0.1 14:24:43 INFO - mozlog == 3.0 14:24:43 INFO - moznetwork == 0.27 14:24:43 INFO - mozprocess == 0.22 14:24:43 INFO - mozprofile == 0.27 14:24:43 INFO - mozrunner == 6.11 14:24:43 INFO - mozscreenshot == 0.1 14:24:43 INFO - mozsystemmonitor == 0.0 14:24:43 INFO - moztest == 0.7 14:24:43 INFO - mozversion == 1.4 14:24:43 INFO - psutil == 3.1.1 14:24:43 INFO - requests == 1.2.3 14:24:43 INFO - wsgiref == 0.1.2 14:24:43 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:24:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:24:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:24:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:43 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7ff8c6d98f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x206d600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fc350>, '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 0x20fd250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20fd6e0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1453155511.984397-1926919890', '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 14:24:43 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 14:24:43 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 14:24:43 INFO - Using env: {'DISPLAY': ':0', 14:24:43 INFO - 'HOME': '/home/cltbld', 14:24:43 INFO - 'LANG': 'en_US.UTF-8', 14:24:43 INFO - 'LANGUAGE': 'en_US:en', 14:24:43 INFO - 'LOGNAME': 'cltbld', 14:24:43 INFO - 'MAIL': '/var/mail/cltbld', 14:24:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:43 INFO - 'MOZ_NO_REMOTE': '1', 14:24:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:24:43 INFO - 'NO_EM_RESTART': '1', 14:24:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:24:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:24:43 INFO - 'PWD': '/builds/slave/test-pgo', 14:24:43 INFO - 'SHELL': '/bin/bash', 14:24:43 INFO - 'SHLVL': '1', 14:24:43 INFO - 'TERM': 'linux', 14:24:43 INFO - 'TMOUT': '86400', 14:24:43 INFO - 'USER': 'cltbld', 14:24:43 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1453155511.984397-1926919890', 14:24:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:43 INFO - '_': '/tools/buildbot/bin/python'} 14:24:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:43 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)) 14:24:43 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)) 14:24:43 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)) 14:24:43 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)) 14:24:43 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)) 14:24:43 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)) 14:24:43 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)) 14:24:43 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)) 14:24:43 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)) 14:24:43 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)) 14:24:43 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)) 14:24:43 INFO - Cleaning up... 14:24:43 INFO - Return code: 0 14:24:43 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 14:24:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:24:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:24:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:43 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff8c6d98f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x206d600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fc350>, '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 0x20fd250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20fd6e0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1453155511.984397-1926919890', '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 14:24:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 14:24:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:24:43 INFO - Using env: {'DISPLAY': ':0', 14:24:43 INFO - 'HOME': '/home/cltbld', 14:24:43 INFO - 'LANG': 'en_US.UTF-8', 14:24:43 INFO - 'LANGUAGE': 'en_US:en', 14:24:43 INFO - 'LOGNAME': 'cltbld', 14:24:43 INFO - 'MAIL': '/var/mail/cltbld', 14:24:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:43 INFO - 'MOZ_NO_REMOTE': '1', 14:24:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:24:43 INFO - 'NO_EM_RESTART': '1', 14:24:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:24:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:24:43 INFO - 'PWD': '/builds/slave/test-pgo', 14:24:43 INFO - 'SHELL': '/bin/bash', 14:24:43 INFO - 'SHLVL': '1', 14:24:43 INFO - 'TERM': 'linux', 14:24:43 INFO - 'TMOUT': '86400', 14:24:43 INFO - 'USER': 'cltbld', 14:24:43 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1453155511.984397-1926919890', 14:24:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:43 INFO - '_': '/tools/buildbot/bin/python'} 14:24:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:43 INFO - Downloading/unpacking jsonschema 14:24:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:24:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:24:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:24:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:24:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:24:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:24:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:24:45 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 14:24:45 INFO - Downloading/unpacking functools32 (from jsonschema) 14:24: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 14:24: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 14:24: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 14:24: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 14:24: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 14:24: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 14:24:45 INFO - Downloading functools32-3.2.3-2.tar.gz 14:24:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 14:24:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 14:24:45 INFO - warning: no files found matching '*.txt' 14:24:45 INFO - no previously-included directories found matching 'build' 14:24:45 INFO - no previously-included directories found matching 'dist' 14:24:45 INFO - no previously-included directories found matching '.git*' 14:24:45 INFO - Installing collected packages: jsonschema, functools32 14:24:45 INFO - Running setup.py install for functools32 14:24:46 INFO - warning: no files found matching '*.txt' 14:24:46 INFO - no previously-included directories found matching 'build' 14:24:46 INFO - no previously-included directories found matching 'dist' 14:24:46 INFO - no previously-included directories found matching '.git*' 14:24:46 INFO - Successfully installed jsonschema functools32 14:24:46 INFO - Cleaning up... 14:24:46 INFO - Return code: 0 14:24:46 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 14:24: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')]} 14:24:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24: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')]} 14:24:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:46 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff8c6d98f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x206d600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fc350>, '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 0x20fd250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20fd6e0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1453155511.984397-1926919890', '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 14:24:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 14:24:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 14:24:46 INFO - Using env: {'DISPLAY': ':0', 14:24:46 INFO - 'HOME': '/home/cltbld', 14:24:46 INFO - 'LANG': 'en_US.UTF-8', 14:24:46 INFO - 'LANGUAGE': 'en_US:en', 14:24:46 INFO - 'LOGNAME': 'cltbld', 14:24:46 INFO - 'MAIL': '/var/mail/cltbld', 14:24:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:46 INFO - 'MOZ_NO_REMOTE': '1', 14:24:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:24:46 INFO - 'NO_EM_RESTART': '1', 14:24:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:24:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:24:46 INFO - 'PWD': '/builds/slave/test-pgo', 14:24:46 INFO - 'SHELL': '/bin/bash', 14:24:46 INFO - 'SHLVL': '1', 14:24:46 INFO - 'TERM': 'linux', 14:24:46 INFO - 'TMOUT': '86400', 14:24:46 INFO - 'USER': 'cltbld', 14:24:46 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1453155511.984397-1926919890', 14:24:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:46 INFO - '_': '/tools/buildbot/bin/python'} 14:24:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:46 INFO - Downloading/unpacking flake8 14:24: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 14:24: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 14:24: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 14:24: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 14:24: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 14:24: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 14:24:48 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:24:48 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 14:24:48 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:24:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:24:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:24:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:24:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:24:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:24:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:24:48 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:24:48 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 14:24:48 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:24:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:24:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:24:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:24:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:24:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:24:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:24:48 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 14:24:48 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:24:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:24:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:24:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:24:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:24:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:24:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:24:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 14:24:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 14:24:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:24:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:24:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:24:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:24:48 INFO - no previously-included directories found matching 'docs/_build' 14:24:48 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:24:48 INFO - Running setup.py install for pep8 14:24:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:24:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:24:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:24:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:24:48 INFO - no previously-included directories found matching 'docs/_build' 14:24:48 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 14:24:48 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:24:48 INFO - Cleaning up... 14:24:48 INFO - Return code: 0 14:24:48 INFO - Running post-action listener: _resource_record_post_action 14:24:48 INFO - Running post-action listener: _start_resource_monitoring 14:24:48 INFO - Starting resource monitoring. 14:24:48 INFO - ##### 14:24:48 INFO - ##### Running install step. 14:24:48 INFO - ##### 14:24:48 INFO - Running pre-action listener: _resource_record_pre_action 14:24:48 INFO - Running main action method: install 14:24:48 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 14:24:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 14:24:49 INFO - Reading from file tmpfile_stdout 14:24:49 INFO - Detecting whether we're running mozinstall >=1.0... 14:24:49 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 14:24:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 14:24:49 INFO - Reading from file tmpfile_stdout 14:24:49 INFO - Output received: 14:24:49 INFO - Usage: mozinstall [options] installer 14:24:49 INFO - Options: 14:24:49 INFO - -h, --help show this help message and exit 14:24:49 INFO - -d DEST, --destination=DEST 14:24:49 INFO - Directory to install application into. [default: 14:24:49 INFO - "/builds/slave/test-pgo"] 14:24:49 INFO - --app=APP Application being installed. [default: firefox] 14:24:49 INFO - mkdir: /builds/slave/test-pgo/build/application 14:24:49 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'] 14:24:49 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 14:25:03 INFO - Reading from file tmpfile_stdout 14:25:03 INFO - Output received: 14:25:03 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 14:25:03 INFO - Running post-action listener: _resource_record_post_action 14:25:03 INFO - ##### 14:25:03 INFO - ##### Running run-tests step. 14:25:03 INFO - ##### 14:25:03 INFO - Running pre-action listener: _resource_record_pre_action 14:25:03 INFO - Running main action method: run_tests 14:25:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 14:25:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 14:25:03 INFO - Python 2.7.3 14:25:03 INFO - Return code: 0 14:25:03 INFO - grabbing minidump binary from tooltool 14:25:03 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')]} 14:25:03 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 0x20fc350>, '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 0x20fd250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20fd6e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 14:25:03 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 14:25:03 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 14:25:03 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:25:03 INFO - Return code: 0 14:25:03 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 14:25:03 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 14:25:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 14:25:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 14:25:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 14:25:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 14:25:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 14:25:04 INFO - Return code: 0 14:25:04 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/1453147231/firefox-44.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 14:25:04 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/1453147231/firefox-44.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --webServer localhost 14:25:04 INFO - Using env: {'DISPLAY': ':0', 14:25:04 INFO - 'HOME': '/home/cltbld', 14:25:04 INFO - 'LANG': 'en_US.UTF-8', 14:25:04 INFO - 'LANGUAGE': 'en_US:en', 14:25:04 INFO - 'LOGNAME': 'cltbld', 14:25:04 INFO - 'MAIL': '/var/mail/cltbld', 14:25:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 14:25:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 14:25:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:25:04 INFO - 'MOZ_NO_REMOTE': '1', 14:25:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 14:25:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:25:04 INFO - 'NO_EM_RESTART': '1', 14:25:04 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:25:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:25:04 INFO - 'PWD': '/builds/slave/test-pgo', 14:25:04 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 14:25:04 INFO - 'SHELL': '/bin/bash', 14:25:04 INFO - 'SHLVL': '1', 14:25:04 INFO - 'TERM': 'linux', 14:25:04 INFO - 'TMOUT': '86400', 14:25:04 INFO - 'USER': 'cltbld', 14:25:04 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1453155511.984397-1926919890', 14:25:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:25:04 INFO - '_': '/tools/buildbot/bin/python'} 14:25:04 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/1453147231/firefox-44.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost'] with output_timeout 3600 14:25:04 INFO - mozversion INFO | application_buildid: 20160118120031 14:25:04 INFO - mozversion INFO | application_changeset: f84fcce02b11da4d97979f4151c10801ae8d9425 14:25:04 INFO - mozversion INFO | application_display_name: Nightly 14:25:04 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:25:04 INFO - mozversion INFO | application_name: Firefox 14:25:04 INFO - mozversion INFO | application_remotingname: firefox 14:25:04 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-beta 14:25:04 INFO - mozversion INFO | application_vendor: Mozilla 14:25:04 INFO - mozversion INFO | application_version: 44.0 14:25:04 INFO - mozversion INFO | platform_buildid: 20160118120031 14:25:04 INFO - mozversion INFO | platform_changeset: f84fcce02b11da4d97979f4151c10801ae8d9425 14:25:04 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-beta 14:25:04 INFO - mozversion INFO | platform_version: 44.0 14:25:04 INFO - 2016-01-18 14:25:04,634 DEBUG : using testdate: 1453155904 14:25:04 INFO - 2016-01-18 14:25:04,634 DEBUG : actual date: 1453155904 14:25:04 INFO - 2016-01-18 14:25:04,681 INFO : starting webserver on 'localhost:50905' 14:25:04 INFO - 2016-01-18 14:25:04,682 INFO : Starting test suite talos-linux64-ix-014 14:25:04 INFO - 2016-01-18 14:25:04,683 INFO : Starting test dromaeo_css 14:25:04 INFO - 2016-01-18 14:25:04,683 DEBUG : operating with platform_type : linux_ 14:25:04 INFO - 2016-01-18 14:25:04,683 INFO : Initialising browser for dromaeo_css test... 14:25:04 INFO - 2016-01-18 14:25:04,696 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpK17Qn_/profile http://localhost:50905/getInfo.html 14:25:08 INFO - 2016-01-18 14:25:08,393 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:25:08 INFO - 2016-01-18 14:25:08,393 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:25:08 INFO - 2016-01-18 14:25:08,393 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 14:25:08 INFO - 2016-01-18 14:25:08,393 DEBUG : BROWSER_OUTPUT: __metrics 14:25:08 INFO - 2016-01-18 14:25:08,490 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] 14:25:09 INFO - 2016-01-18 14:25:09,582 INFO : Browser initialized. 14:25:09 INFO - 2016-01-18 14:25:09,583 INFO : Running cycle 1/1 for dromaeo_css test... 14:25:09 INFO - 2016-01-18 14:25:09,583 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpK17Qn_/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:25:21 INFO - 2016-01-18 14:25:21,138 DEBUG : BROWSER_OUTPUT: RSS: Main: 129155072 14:25:21 INFO - 2016-01-18 14:25:21,138 DEBUG : BROWSER_OUTPUT: 14:26:12 INFO - 2016-01-18 14:26:12,985 DEBUG : BROWSER_OUTPUT: 1453155972982 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] 14:28:19 INFO - 2016-01-18 14:28:19,761 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50905/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50905/tests/dromaeo/cssquery-ext.html) 14:28:20 INFO - 2016-01-18 14:28:20,846 DEBUG : BROWSER_OUTPUT: RSS: Main: 238239744 14:28:20 INFO - 2016-01-18 14:28:20,846 DEBUG : BROWSER_OUTPUT: 14:31:22 INFO - 2016-01-18 14:31:22,906 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50905/tests/dromaeo/cssquery-ext.html (next: http://localhost:50905/tests/dromaeo/cssquery-jquery.html) 14:31:23 INFO - 2016-01-18 14:31:23,468 DEBUG : BROWSER_OUTPUT: RSS: Main: 203247616 14:31:23 INFO - 2016-01-18 14:31:23,469 DEBUG : BROWSER_OUTPUT: 14:34:25 INFO - 2016-01-18 14:34:25,017 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50905/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50905/tests/dromaeo/cssquery-mootools.html) 14:34:25 INFO - 2016-01-18 14:34:25,583 DEBUG : BROWSER_OUTPUT: RSS: Main: 203218944 14:34:25 INFO - 2016-01-18 14:34:25,584 DEBUG : BROWSER_OUTPUT: 14:37:27 INFO - 2016-01-18 14:37:27,294 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50905/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50905/tests/dromaeo/cssquery-prototype.html) 14:37:27 INFO - 2016-01-18 14:37:27,864 DEBUG : BROWSER_OUTPUT: RSS: Main: 192614400 14:37:27 INFO - 2016-01-18 14:37:27,864 DEBUG : BROWSER_OUTPUT: 14:40:30 INFO - 2016-01-18 14:40:30,200 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50905/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50905/tests/dromaeo/cssquery-yui.html) 14:40:30 INFO - 2016-01-18 14:40:30,762 DEBUG : BROWSER_OUTPUT: RSS: Main: 195092480 14:40:30 INFO - 2016-01-18 14:40:30,763 DEBUG : BROWSER_OUTPUT: 14:43:32 INFO - 2016-01-18 14:43:32,631 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50905/tests/dromaeo/cssquery-yui.html (next: http://localhost:50905/tests/dromaeo/cssquery-dojo.html) 14:43:32 INFO - 2016-01-18 14:43:32,878 DEBUG : BROWSER_OUTPUT: RSS: Main: 239214592 14:43:32 INFO - 2016-01-18 14:43:32,878 DEBUG : BROWSER_OUTPUT: 14:43:32 INFO - 2016-01-18 14:43:32,879 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:43:32 INFO - 2016-01-18 14:43:32,880 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:43:32 INFO - 2016-01-18 14:43:32,880 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:43:32 INFO - 2016-01-18 14:43:32,880 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:43:32 INFO - 2016-01-18 14:43:32,881 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3308.7353011759055;3344.5819272590925;3375.8143302118388;3381.7125544328715;3396.3037577296654;5538.6399884007515;5549.472800083986;5557.555395568355;5557.7776888924445;5576.414476479972;5573.637713548616;5587.525060369863;5590.161475778636;5597.384287728357;5599.160125981105;4945.826896058638;5073.873153171182;5098.337216161913;5162.277281180638;5217.556507696831;4987.800487980477;4988.725620090893;5043.823466178685;5049.772760225798;5076.8730781730565;5126.846194614168;5151.4075881273575;5158.380994280692;5191.0656081905245;5204.34945631796;4987.077390682735;5101.464346243665;5105.463926287724;5144.56271216947;5182.222666600002;4977.576905962997;4992.176290911995;5044.344235249394;5049.873753156164;5061.5950723942;5363.302770639831;5416.025115479212;5445.237666726662;5453.018456677796;5485.6434331768305;5965;6075.665838378887;6086.315012910367;6086.726097325631;6095.512359011268;5938.792142275;6001.48987336077;6006;6011.12838638395;6023.45788879003;5601.215829783833;5684.261046063985;5686.0333743263745;5686.14707793826;5694.430556944314;5975.790847320323;6053.545984051214;6080.452759251689;6099.420555047263;6106.755729770848;5973.850653733692;5977.043673012384;5981.970090149522;5985.132155837467;5987.161797348374;6069.3627169147485;6070.998285282879;6075.149479072933;6080.179175811209;6080.695965201722;5761.683107429131;5860.619059761102;6037.879242415127;6057.3336932937345;6114.4062736356245;6006.969965150233;6010.759569617254;6011.368806275365;6014.849628759229;6023.6385816851125;4605.6085232755595;4605.677602567788;4608.124456353282;4610.3084537319;4634.791434385461;4012.498437695288;4036.273470775289;4091.8363265469047;4115.8971025723995;4117.464729585135;5684.8294551163535;5718.370979192286;5724.255846739898;5729.684867332337;5743.195952566644;5861.296644402613;6072.666003369857;6075.2405949256345;6086.786962456293;6100.176476175749;5601.383847776741;5613.7193140342815;5645.689487078168;5665.3768085510565;5689.516391106719;5246.921296180561;5299.761510731949;5302.92045619316;5308.575313974873;5309.044372012998;5992.0712289595185;6069.089636554552;6247;6270.059491076375;6287.088372186007;5948.7323070461935;6035.728392222272;6036.9094463582205;6047.455728984412;6075.27096748393;6100.481459076028;6269.467095296951;6292.716827742855;6302.747890084345;6330.651814150082;5727.68497732612;5877.059670452707;5931.881362372642;6054.75780968774;6067.150598916243;6130.873254640076;6144.508439324753;6145.0782382642965;6150.169727086965;6156.045812899008;5974.701264936649;5977.521798256216;5981.790637327673;5986.2517185351835;5993.340732519507;5725.570582206268;5808.15781711641;5825.883482330414;5940.376260492586;5958.285005799332;5770.394108618535;5774.0761478163295;5775;5795.536357091507;5829.387914268941;5817.301923769175;5864.706764661664;5879.676617785892;5924.674142922181;5930.881382372242;5652.463016013472;5660.490555849993;5685.658860468385;5765.423457654201;5875.6474611523445 14:43:32 INFO - 2016-01-18 14:43:32,882 DEBUG : BROWSER_OUTPUT: |1;ext.html;585.4935480809102;642.7653906324192;643.0836058616471;652.794369773521;658.8319978405503;36351.272974540494;44641;45210.321845172264;45235.321470177936;45272.3209151863;49249.55253132282;49749.25376119352;49874.251886221646;49896.50103498964;49900.75049624756;8351.791205219888;8454.830903381928;9240.676576319847;9337.206337461324;10684.679459616224;10857.185711071661;10961;10962.068224200952;10995.175361847854;11012.063974562172;10951.780964380707;11052.613158539452;11067.114630829514;11068.446577671124;11069.280496767724;8557.786055348604;8741;10971.396573188471;11292.717682057932;11296.209265351428;10853.5115919783;10994.945025274903;10995.285306455135;10995.505202265836;11006.834897476545;45375.31937020947;45997.310040349425;46041.53958460406;46047.53952460466;46079;3334.7665663403573;3569.1790888095884;3626.582942961567;3705.40713485841;3734.309152806712;33993.6600633993;34444;34472.31055378878;34495.31009379798;34523.30953380918;3339.96660033399;3375.1562109472634;3387.6104248011547;3481.2863363010774;3491.14466955595;329042;330291;330379;330863;331079;72190.2780972194;72518.63740681263;72575;72632.63683681548;72736;76684.23315766883;77187;77292.61353693307;77315;77419.61290193514;17249.39627113045;17501.912490437466;17593.91203044002;17670.82329176692;17690.380836670913;13495.730085398238;13528;13539.255340956144;13569.389377478037;13574.59276221715;23033.654495182585;23325.53348933012;23441.7655823443;23445.296641100795;23472;8549.529775862387;8744.519051452231;8870.467771933705;8958.10418958099;8988.370814042953;986.8026394721085;1045.6078970386104;1057.6525297433536;1116.4083035990939;1145.7078444996473;31578.36843263168;31995;32312.35375292528;34507.65492345044;35183.824080879946;1045.72288343589;1070.8340207267886;1144.2162118948547;1161.5818305410046;1194.0328334049448;14864.925675371771;16770.74843877343;16930.238139283763;16941.06824124685;17246.65506689859;296665;299568;299929;299951;300197;57103.71448142733;57369.13946290809;57459;57488.425115749145;57648.42351576514;1488.8287846897529;1494.3873012065;1509.3434356055152;1516.780066890317;1518.855708707671;30035.69964300329;30147.69852301449;31656.841715791274;31750.364992699553;32686.34627307393;57374.42625573691;59156.70421647864;59198.04009799407;59243.40756592551;59445.405545943984;243756;244505;245113;245355;245834;31950.201244969063;32398.51402228921;35513.64486355103;35949.1012724684;36916.261674766894;44750.552494474636;45282;45459.31811022771;45872;45908.311375328725;38010.61989380071;38122.809385952896;38219.42670859995;38387;39289.60710392974;38210.235795283385;40210;41004;41153.38269925894;42260;35877.82061089678;41032.79483602563;41610.37584436296;41673;42277.15445691007;33867.49198761971;35828.462573061945;35964.280714385044;36248.27503449969;37633.81183094067;25785.355366115997;26473.470530588897;27363.33973986492;28211.2947176314;28257.293567660974 14:43:32 INFO - 2016-01-18 14:43:32,884 DEBUG : BROWSER_OUTPUT: |2;jquery.html;370.6756587985513;373.21438372226464;385.96912247020225;387.0126898376834;387.0594455473201;17640;19850.801491985076;20169.495762605904;20315.695264571026;20340;18356.81643183568;18443.17005734742;18542.90728546359;18650.906745466287;19021.809781902175;5645.774169033234;5766.365699773021;5773.971130144343;5777.480026797598;5778.6243894146955;5669.319681638209;5696.829095127132;5746.0806270996645;5748;5757.625754325976;4319.69762116652;4457.799399027052;5684.857878553028;5701.828945131652;5711.628744131639;5984.940150598503;6126.111713801519;6168.784092556739;6169.907451388232;6191.318954914956;4400.229959757062;4469.888252793674;4483.08096840147;5406.216098665711;5410.3507579090365;14623.122612643276;14726;14814.629634259121;14838.70322593542;14853.2573371331;2008.1967213114724;2097.6958341040463;2141.7108690326763;2148.398448434441;2239.7648246934;10423.739406514822;10477.26659133861;10485.370877747284;10492.895071049345;10513.684589462327;1686.1569215392303;1694.3730819596828;1717.6135369541878;1756.3150371355182;1769.0889192066097;63678.68160659167;65697.67151164262;65860.67069664669;65935;65977.34022659808;7830.804229894185;7884;7917.524948503108;7960.880586791202;7973.800654983672;9558.665446709332;9574;9577;9577.090176433228;9580.0898914603;6060.33336333003;6094;6122.571420000557;6123.142760013601;6153.8461538461;6153.600015998945;6168.599041062316;6179.16581261524;6248.062790581449;6328.208973878265;3580;3667.468217108504;3668.2663467306647;3690.391085470921;3693.1874987502706;1252.4426630149496;1254.4731212890608;1254.9686257843443;1260.3257257367266;1285.1710646632869;435.18185810675726;506.82261208576705;511;555.7832445346318;567.9744411501492;12642.620721378373;12711.61865144047;13068.346582670829;13080.672983175496;13086.672833179247;533.7998250656004;537.3712756075402;556.7800718716085;562.831150654802;572.0561074227558;7055;7132.393746531603;7276.272372762682;7299.744508942162;7303.194274742559;647634;647636;658086;670310;675688;61440.69279653663;72264.91602625964;74813;75050;76228.61885690536;592.7362323765883;608.7747533412665;609.6007115339548;610.8167549735061;610.9266887973472;11656.76686466249;11909.821352679543;12021.75956480883;12084.093692972887;12135.02919766399;34458;34567.308653827284;34629.65370346365;36062.819685901406;36529.26941461209;46432;47142.76428617972;51563.22655160251;52678.73660631672;53910.46089539054;7381.26187381279;7560.886586701094;7580.62096895142;7586.582737949466;7592.202818703957;13254.801177982145;13256.933715331748;13347.199168049949;13547.187168769906;13636.181829090287;11308.49111789955;11468.598599048993;11559.190856639954;11904.58333958342;11947.163698541019;2633.9341516461477;3988.720789544704;7466.954626352206;11685.76628467443;12080.39598020113;11747.353895535827;11774;11845.644630661094;12440.937795311327;12467.75064498723;7665.6933722650465;7728.92271077282;7755.3407960324;7757.806054848448;7759.2240775921955;11974;12131.575394861138;12302.138850280753;12304;12480.375981200723 14:43:32 INFO - 2016-01-18 14:43:32,885 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1577.723898317795;1580.344157174772;1789.337944960365;1872.7378167056615;1880.2385034061206;7355.3012463815985;7453.254674532544;7778.961105194473;7958.522488650685;7971.800704982378;7911.129775724666;8019.839603207933;8088.67645294189;8100.716474923379;8110.797230069251;2376.6435034744754;2413.2880800163994;2418.89114989825;2418.9153379631716;2419.2742177346727;2135.893205339735;2181.6291230490856;2340.602097643396;2395.628677554973;2399.36416849535;2284.440312123532;2286.576983258094;2287.839851210416;2289.2788771537;2298.655201719747;2427.7936375408112;2451.3381387025493;2453.031052734178;2453.595156799135;2454.619533972237;2403.8557686538866;2458.6680798092207;2461.3477428481287;2464.0759715106833;2464.1745015419856;8237.299829514499;8290.41967062306;8305.044919834236;8316.501009939422;8317.750467485985;5012.323336349619;5074.847754567369;5089.618278629117;5089.643724939256;5091.87270318245;3171.4767063434506;3180.3003339265324;3274.9017529474154;3278.6721327867263;3295.20914980403;1052.4842827014784;1055.72551136705;1071.212658695858;1073.4595854948097;1082.5290998415635;11393.373364464951;11397.373144477051;11409;11411.201215914889;11421.371824549646;4626.1210370029585;4629.722216667011;4677.22825733757;4694.600958918462;4709.222978208557;9820.754481138028;9853.655122070693;9866.851997220047;9881.25890558211;9885.357451765612;5097.796088156507;5107.591392688576;5109.744512774347;5115.386153661584;5115.87210319745;4644.535546445329;4650;4656.906861862743;4661.906761864744;4664.043871006435;3504.5268888700207;3976.0855003348815;4002.479677641888;4027.7986100694848;4043.7775922323967;1238.6036468330049;1242.726600147966;1282.3075539208724;1284.6531436512275;1291.599604122725;1174.2191442690687;1183.9822402663967;1184.08233618946;1187.8990285825628;1332.9400176992058;7875.527468351917;7883.2116788321855;7918.366530677532;7947.562884041433;7993.080795708452;1201.9663089742814;1280.6798300424894;1299.493197652916;1306.9019823513274;1316.9539066132638;6295.622262664255;6338;6342.143810585604;6343.333949935282;6359.491240700733;9603.231741460666;10184.541695623715;10189.847152292721;10209.846852297222;10218.540165692562;9924.007599240018;10047.648332308334;10067.093961543496;10074.647387341407;10086.546105425274;7855.921440785633;7969.760907172794;7987.241212084843;7994.920050799534;7997.640106195236;7573.886391704239;7585.469017168966;7648.80877978055;7665.3101220890385;7671.462997590338;8884.644614215358;8925.73222803317;8962;8979.326550508607;9179.954100229723;9209.401388909699;9289.581968811284;9307.86038209441;9313.860292095489;9410.952945235504;6929.168499779857;6982.33667801558;6982.546134501241;6994.9300506996315;7002.474814388839;6966.79099627012;7382.9261707384385;7767.495112817649;7772.106207786177;7920.405969552191;7323.194448610755;7362.77911662651;7433.8141546461775;7539.509931854412;7676.846463070819;7241;7311.232320606472;7323.2676732326345;7380.96309518449;7421.146568144733;7457.2542745724995;7617.961910190414;7618.200088990798;7624.085109786861;7644.235576442311;6899.103116594811;6930.5148639594745;6931.0643063187845;6932.306769323028;6936.4797640176175;6954.826129346807;6994.33553812387;6995.860082798417;6999;6999.195092564217 14:43:32 INFO - 2016-01-18 14:43:32,887 DEBUG : BROWSER_OUTPUT: |4;prototype.html;362.99092522686936;366.93578623740837;368.0577721034151;370.83312509370774;376.8624452074993;5916.970415147918;5957;5979.551533634973;5990.910136347953;5999.850003749903;5849.707514624273;5927.8221653350365;5936.376680448556;5940.405959404057;5942.544076701203;4660;4661.3241080043545;4664.906701865961;4668.25307950728;4669.976650116745;4500.639948804088;4563.7489938053395;4590.862274131765;4668.626509879218;4680.695754775946;4620.099080679269;4620.768961551926;4623.5838774510285;4642.048380082075;4646.697964632305;4609.792559334838;4613.284940834176;4613.723176609381;4621.838235661752;4632.791524381377;4123.134141830219;4126.628603425676;4127.40152677863;4129.174165166949;4130.256553820311;5560.388357280696;5577.3028371453565;5623.915641265385;5636.605437619368;5671.51792097668;5326.547243484309;5335.1997200419855;5360.544353729938;5367.0339338918975;5369.892602147936;6026.789062382795;6221.688915554249;6222.191115155001;6223.315435302113;6234.812955611339;4379.671524635665;4416.116776644684;4418.447694038246;4454.265046267362;4467.642588592905;6428.485721142344;6433.453156481704;6451.645159516272;6454.741810327581;6461.450776683941;4552.908941821212;4558.49856515783;4558.658100642465;4560.543945605479;4561.29299958507;4538.410006699174;4613.95386046142;4615.538446155358;4677.859664210079;4682.016776476978;5353.4646535346155;5356.892862142735;5358.115910874662;5361.758720857571;5363.678179309254;6400.23197216337;6402.551821372553;6404;6408.2630497492455;6410;1701.6171361443576;1725.9299234474706;1727.3522429089091;1727.7322015087682;1728.8184740602308;1156.3986726901965;1166.4984056855465;1171.654361963206;1172.9882701172878;1214.0651698192341;6198.845028874314;6199.3490683478485;6200.534959878028;6204.317525072239;6205.906911396332;6552.246491653425;6553.541252112402;6559.819232538093;6563.113979612786;6593.472522198213;6040.124181993674;6156.569040167145;6159.3224745277985;6160.7535698571555;6164.938350616526;3589.4615807629066;3623.2572322673786;3629.564452265745;3643.7267204959735;3645.85416583339;6712.328767123248;6718.66406679664;6735.326467353226;6742.292059333798;6749.93250067493;6619.470442364599;6714.9664251679405;6717.193936727624;6724.058631791553;6724.966375168093;6678.565893216925;6698.933010669928;6704.597724136567;6712.496562757813;6717.563358381787;6370.490360771035;6457.903131452938;6518.869622607426;6544.770933017321;6572.901406478811;6403.935960640334;6448.258450278278;6486.254080780582;6486.805395838132;6488.188976377953;6639.502037347122;6676.298988606321;6676.566023208476;6694.59832410057;6704.76533321351;4577.138241541147;4631.305304204397;4637.698549594401;4640.095181439587;4677.859664210079;6582.605043697394;6606.801795945937;6611.900821487586;6612;6614.338566143347;6404.327545607644;6414.390632889868;6423.582467139621;6428.132202152837;6438.8390290243115;6328.810135695752;6405.03924411342;6405.135306733718;6411.102445657705;6413.038044293393;6323.620582764865;6323.956547169665;6326.145970293951;6331.05034244867;6332.398422149889;6463.062855885964;6469.159009328945;6470.7088181032905;6475.384838440341;6475.7733479328;6228.937710623017;6287.402696743802;6321.589096708699;6322.525810564134;6323.494120470444 14:43:32 INFO - 2016-01-18 14:43:32,888 DEBUG : BROWSER_OUTPUT: |5;yui.html;706.7385067525015;741.2106106996052;776.3401109057302;782.8434313137374;828.5012382761602;13423.530176443826;13882.236476993761;13890;13893.791593126098;13898.861011389883;13865.653358666039;14246;14680.412783488648;14684.632884177901;14685.825133989281;773.760134358348;782.4561929459028;890.4167770110572;903.9728808135767;905.678484138128;895.2166854002747;897.0222457521301;901.6708901251029;903.069838066789;904.3036861616552;952.5427794658568;954.627695198873;954.7422196007074;954.937929034614;956.3687965942479;940.1256831147031;942.203837757101;942.4957647658538;943.8065196634708;947.5735918836517;697.4246246846373;702.4099756204813;704.105785652224;705.2947052947053;707.4835370179798;14170.787438188436;14278.428862845474;14285.714285714228;14311.499097531536;14314.42742290307;11675.299482031105;12010.759784804342;12028;12223.266604003788;12268.754624907451;9952.850707239397;10017.749556261078;10051.798964020678;10060.69817905464;10071.69784906454;3307.9503807442907;3358.958722795941;3360.6807353301397;3364.8317584120696;3369.629340772513;49109;49150;49170.26244606334;51324;54115.18827217595;9502.952485237529;9621.326507144573;9622.51887405627;9653.276004299705;9658.323917325719;20792.37622871316;20856.58286834255;20879.582408351747;20934.685979710317;20937.37187884366;7118.644067796589;7172.892406613905;7225.819354516179;7307.342339189392;7312.085989251344;4141.91716165681;4157.293260145782;4162.771047592351;4206.894827629334;4218.430511880918;3026;3056.480398332289;3058.8776448941794;3059.174023013774;3059.9235019124253;457.76425141052385;467.8900458392275;473.70630209269785;473.8838984448763;475.46985111600316;495.76946719775475;529.1718460609135;545.8007827143064;559.1891756952435;650.0898741761572;8069.072056713436;8478.152184781473;8498.575071246412;8701.17338852808;8719.520426376483;527.9841604751787;538.496505767109;556.3824155187739;579.1775678536488;639.3766078073841;3700.7224458165206;3860.6911447084167;3864.8454061837774;3987.6809855211513;3988.3020471417967;67752;69258;69295;69441.65279173572;69689.65155174192;59259;59951.400485994585;60237.69881150566;60305.09542356868;60385;54975;55088.72455637776;55301;55990.16014759782;56259.71870140705;7945.761627151194;7970.8007299815645;7977.840443190988;7999.720009799629;8190.1400352964465;38887.41668874912;39327.41008884812;40491.19017619572;40498;41432.1713565721;49393.50606493889;53296.73351633217;53504;54631;55331.44668553424;7774.572398517909;7787.727429539939;8000.359971202406;8080.4343695940715;8145.470544414594;10912.890871091187;11038.613648522263;11157.27477713946;11360.1479889007;11469;9786.41281523111;9887.456189909624;9949.850752238577;10032.69901902944;10221.182305415401;10921.508532116233;11023.61417350389;11058.447077645924;11202.21584489078;11472.827907581226;9924.553395097093;9986.35088719231;10046.899531004596;10047.447390393307;10129.544170512198;9207.76980575491;9511.66709165176;9933;9955.253355998473;9992.850107248543;8421.284190843848;8441.268866008017;8503.617337219715;8568.100349463217;8736.25741811953 14:43:32 INFO - 2016-01-18 14:43:32,888 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:43:32 INFO - 2016-01-18 14:43:32,888 DEBUG : BROWSER_OUTPUT: __start_cc_report 14:43:32 INFO - 2016-01-18 14:43:32,888 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,832 14:43:32 INFO - 2016-01-18 14:43:32,888 DEBUG : BROWSER_OUTPUT: __end_cc_report 14:43:32 INFO - 2016-01-18 14:43:32,889 DEBUG : BROWSER_OUTPUT: __startTimestamp1453157012879__endTimestamp 14:43:32 INFO - 2016-01-18 14:43:32,889 DEBUG : BROWSER_OUTPUT: 14:43:32 INFO - 2016-01-18 14:43:32,889 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:43:32 INFO - 2016-01-18 14:43:32,889 DEBUG : BROWSER_OUTPUT: Number of tests: 6 14:43:32 INFO - 2016-01-18 14:43:32,889 DEBUG : BROWSER_OUTPUT: 14:43:32 INFO - 2016-01-18 14:43:32,889 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5586.32 Median:5770.39 stddev:630.82 (10.9%) stddev-sans-first:606.93 14:43:32 INFO - 2016-01-18 14:43:32,889 DEBUG : BROWSER_OUTPUT: Values: 3308.7 3344.6 3375.8 3381.7 3396.3 5538.6 5549.5 5557.6 5557.8 5576.4 5573.6 5587.5 5590.2 5597.4 5599.2 4945.8 5073.9 5098.3 5162.3 5217.6 4987.8 4988.7 5043.8 5049.8 5076.9 5126.8 5151.4 5158.4 5191.1 5204.3 4987.1 5101.5 5105.5 5144.6 5182.2 4977.6 4992.2 5044.3 5049.9 5061.6 5363.3 5416.0 5445.2 5453.0 5485.6 5965.0 6075.7 6086.3 6086.7 6095.5 5938.8 6001.5 6006.0 6011.1 6023.5 5601.2 5684.3 5686.0 5686.1 5694.4 5975.8 6053.5 6080.5 6099.4 6106.8 5973.9 5977.0 5982.0 5985.1 5987.2 6069.4 6071.0 6075.1 6080.2 6080.7 5761.7 5860.6 6037.9 6057.3 6114.4 6007.0 6010.8 6011.4 6014.8 6023.6 4605.6 4605.7 4608.1 4610.3 4634.8 4012.5 4036.3 4091.8 4115.9 4117.5 5684.8 5718.4 5724.3 5729.7 5743.2 5861.3 6072.7 6075.2 6086.8 6100.2 5601.4 5613.7 5645.7 5665.4 5689.5 5246.9 5299.8 5302.9 5308.6 5309.0 5992.1 6069.1 6247.0 6270.1 6287.1 5948.7 6035.7 6036.9 6047.5 6075.3 6100.5 6269.5 6292.7 6302.7 6330.7 5727.7 5877.1 5931.9 6054.8 6067.2 6130.9 6144.5 6145.1 6150.2 6156.0 5974.7 5977.5 5981.8 5986.3 5993.3 5725.6 5808.2 5825.9 5940.4 5958.3 5770.4 5774.1 5775.0 5795.5 5829.4 5817.3 5864.7 5879.7 5924.7 5930.9 5652.5 5660.5 5685.7 5765.4 5875.6 14:43:32 INFO - 2016-01-18 14:43:32,889 DEBUG : BROWSER_OUTPUT: 14:43:32 INFO - 2016-01-18 14:43:32,889 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:49565.18 Median:34483.81 stddev:76583.46 (222.1%) stddev-sans-first:76709.99 14:43:32 INFO - 2016-01-18 14:43:32,890 DEBUG : BROWSER_OUTPUT: Values: 585.5 642.8 643.1 652.8 658.8 36351.3 44641.0 45210.3 45235.3 45272.3 49249.6 49749.3 49874.3 49896.5 49900.8 8351.8 8454.8 9240.7 9337.2 10684.7 10857.2 10961.0 10962.1 10995.2 11012.1 10951.8 11052.6 11067.1 11068.4 11069.3 8557.8 8741.0 10971.4 11292.7 11296.2 10853.5 10994.9 10995.3 10995.5 11006.8 45375.3 45997.3 46041.5 46047.5 46079.0 3334.8 3569.2 3626.6 3705.4 3734.3 33993.7 34444.0 34472.3 34495.3 34523.3 3340.0 3375.2 3387.6 3481.3 3491.1 329042.0 330291.0 330379.0 330863.0 331079.0 72190.3 72518.6 72575.0 72632.6 72736.0 76684.2 77187.0 77292.6 77315.0 77419.6 17249.4 17501.9 17593.9 17670.8 17690.4 13495.7 13528.0 13539.3 13569.4 13574.6 23033.7 23325.5 23441.8 23445.3 23472.0 8549.5 8744.5 8870.5 8958.1 8988.4 986.8 1045.6 1057.7 1116.4 1145.7 31578.4 31995.0 32312.4 34507.7 35183.8 1045.7 1070.8 1144.2 1161.6 1194.0 14864.9 16770.7 16930.2 16941.1 17246.7 296665.0 299568.0 299929.0 299951.0 300197.0 57103.7 57369.1 57459.0 57488.4 57648.4 1488.8 1494.4 1509.3 1516.8 1518.9 30035.7 30147.7 31656.8 31750.4 32686.3 57374.4 59156.7 59198.0 59243.4 59445.4 243756.0 244505.0 245113.0 245355.0 245834.0 31950.2 32398.5 35513.6 35949.1 36916.3 44750.6 45282.0 45459.3 45872.0 45908.3 38010.6 38122.8 38219.4 38387.0 39289.6 38210.2 40210.0 41004.0 41153.4 42260.0 35877.8 41032.8 41610.4 41673.0 42277.2 33867.5 35828.5 35964.3 36248.3 37633.8 25785.4 26473.5 27363.3 28211.3 28257.3 14:43:32 INFO - 2016-01-18 14:43:32,891 DEBUG : BROWSER_OUTPUT: 14:43:32 INFO - 2016-01-18 14:43:32,891 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:31080.53 Median:46787.38 stddev:107886.43 (230.6%) stddev-sans-first:108164.43 14:43:32 INFO - 2016-01-18 14:43:32,891 DEBUG : BROWSER_OUTPUT: Values: 370.7 373.2 386.0 387.0 387.1 17640.0 19850.8 20169.5 20315.7 20340.0 18356.8 18443.2 18542.9 18650.9 19021.8 5645.8 5766.4 5774.0 5777.5 5778.6 5669.3 5696.8 5746.1 5748.0 5757.6 4319.7 4457.8 5684.9 5701.8 5711.6 5984.9 6126.1 6168.8 6169.9 6191.3 4400.2 4469.9 4483.1 5406.2 5410.4 14623.1 14726.0 14814.6 14838.7 14853.3 2008.2 2097.7 2141.7 2148.4 2239.8 10423.7 10477.3 10485.4 10492.9 10513.7 1686.2 1694.4 1717.6 1756.3 1769.1 63678.7 65697.7 65860.7 65935.0 65977.3 7830.8 7884.0 7917.5 7960.9 7973.8 9558.7 9574.0 9577.0 9577.1 9580.1 6060.3 6094.0 6122.6 6123.1 6153.8 6153.6 6168.6 6179.2 6248.1 6328.2 3580.0 3667.5 3668.3 3690.4 3693.2 1252.4 1254.5 1255.0 1260.3 1285.2 435.2 506.8 511.0 555.8 568.0 12642.6 12711.6 13068.3 13080.7 13086.7 533.8 537.4 556.8 562.8 572.1 7055.0 7132.4 7276.3 7299.7 7303.2 647634.0 647636.0 658086.0 670310.0 675688.0 61440.7 72264.9 74813.0 75050.0 76228.6 592.7 608.8 609.6 610.8 610.9 11656.8 11909.8 12021.8 12084.1 12135.0 34458.0 34567.3 34629.7 36062.8 36529.3 46432.0 47142.8 51563.2 52678.7 53910.5 7381.3 7560.9 7580.6 7586.6 7592.2 13254.8 13256.9 13347.2 13547.2 13636.2 11308.5 11468.6 11559.2 11904.6 11947.2 2633.9 3988.7 7467.0 11685.8 12080.4 11747.4 11774.0 11845.6 12440.9 12467.8 7665.7 7728.9 7755.3 7757.8 7759.2 11974.0 12131.6 12302.1 12304.0 12480.4 14:43:32 INFO - 2016-01-18 14:43:32,891 DEBUG : BROWSER_OUTPUT: 14:43:32 INFO - 2016-01-18 14:43:32,891 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5820.44 Median:5112.57 stddev:3005.92 (58.8%) stddev-sans-first:2997.44 14:43:32 INFO - 2016-01-18 14:43:32,891 DEBUG : BROWSER_OUTPUT: Values: 1577.7 1580.3 1789.3 1872.7 1880.2 7355.3 7453.3 7779.0 7958.5 7971.8 7911.1 8019.8 8088.7 8100.7 8110.8 2376.6 2413.3 2418.9 2418.9 2419.3 2135.9 2181.6 2340.6 2395.6 2399.4 2284.4 2286.6 2287.8 2289.3 2298.7 2427.8 2451.3 2453.0 2453.6 2454.6 2403.9 2458.7 2461.3 2464.1 2464.2 8237.3 8290.4 8305.0 8316.5 8317.8 5012.3 5074.8 5089.6 5089.6 5091.9 3171.5 3180.3 3274.9 3278.7 3295.2 1052.5 1055.7 1071.2 1073.5 1082.5 11393.4 11397.4 11409.0 11411.2 11421.4 4626.1 4629.7 4677.2 4694.6 4709.2 9820.8 9853.7 9866.9 9881.3 9885.4 5097.8 5107.6 5109.7 5115.4 5115.9 4644.5 4650.0 4656.9 4661.9 4664.0 3504.5 3976.1 4002.5 4027.8 4043.8 1238.6 1242.7 1282.3 1284.7 1291.6 1174.2 1184.0 1184.1 1187.9 1332.9 7875.5 7883.2 7918.4 7947.6 7993.1 1202.0 1280.7 1299.5 1306.9 1317.0 6295.6 6338.0 6342.1 6343.3 6359.5 9603.2 10184.5 10189.8 10209.8 10218.5 9924.0 10047.6 10067.1 10074.6 10086.5 7855.9 7969.8 7987.2 7994.9 7997.6 7573.9 7585.5 7648.8 7665.3 7671.5 8884.6 8925.7 8962.0 8979.3 9180.0 9209.4 9289.6 9307.9 9313.9 9411.0 6929.2 6982.3 6982.5 6994.9 7002.5 6966.8 7382.9 7767.5 7772.1 7920.4 7323.2 7362.8 7433.8 7539.5 7676.8 7241.0 7311.2 7323.3 7381.0 7421.1 7457.3 7618.0 7618.2 7624.1 7644.2 6899.1 6930.5 6931.1 6932.3 6936.5 6954.8 6994.3 6995.9 6999.0 6999.2 14:43:32 INFO - 2016-01-18 14:43:32,891 DEBUG : BROWSER_OUTPUT: 14:43:32 INFO - 2016-01-18 14:43:32,892 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5339.32 Median:6033.46 stddev:1566.81 (26.0%) stddev-sans-first:1526.03 14:43:32 INFO - 2016-01-18 14:43:32,893 DEBUG : BROWSER_OUTPUT: Values: 363.0 366.9 368.1 370.8 376.9 5917.0 5957.0 5979.6 5990.9 5999.9 5849.7 5927.8 5936.4 5940.4 5942.5 4660.0 4661.3 4664.9 4668.3 4670.0 4500.6 4563.7 4590.9 4668.6 4680.7 4620.1 4620.8 4623.6 4642.0 4646.7 4609.8 4613.3 4613.7 4621.8 4632.8 4123.1 4126.6 4127.4 4129.2 4130.3 5560.4 5577.3 5623.9 5636.6 5671.5 5326.5 5335.2 5360.5 5367.0 5369.9 6026.8 6221.7 6222.2 6223.3 6234.8 4379.7 4416.1 4418.4 4454.3 4467.6 6428.5 6433.5 6451.6 6454.7 6461.5 4552.9 4558.5 4558.7 4560.5 4561.3 4538.4 4614.0 4615.5 4677.9 4682.0 5353.5 5356.9 5358.1 5361.8 5363.7 6400.2 6402.6 6404.0 6408.3 6410.0 1701.6 1725.9 1727.4 1727.7 1728.8 1156.4 1166.5 1171.7 1173.0 1214.1 6198.8 6199.3 6200.5 6204.3 6205.9 6552.2 6553.5 6559.8 6563.1 6593.5 6040.1 6156.6 6159.3 6160.8 6164.9 3589.5 3623.3 3629.6 3643.7 3645.9 6712.3 6718.7 6735.3 6742.3 6749.9 6619.5 6715.0 6717.2 6724.1 6725.0 6678.6 6698.9 6704.6 6712.5 6717.6 6370.5 6457.9 6518.9 6544.8 6572.9 6403.9 6448.3 6486.3 6486.8 6488.2 6639.5 6676.3 6676.6 6694.6 6704.8 4577.1 4631.3 4637.7 4640.1 4677.9 6582.6 6606.8 6611.9 6612.0 6614.3 6404.3 6414.4 6423.6 6428.1 6438.8 6328.8 6405.0 6405.1 6411.1 6413.0 6323.6 6324.0 6326.1 6331.1 6332.4 6463.1 6469.2 6470.7 6475.4 6475.8 6228.9 6287.4 6321.6 6322.5 6323.5 14:43:32 INFO - 2016-01-18 14:43:32,893 DEBUG : BROWSER_OUTPUT: 14:43:32 INFO - 2016-01-18 14:43:32,893 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14919.11 Median:55316.22 stddev:18880.15 (34.1%) stddev-sans-first:18902.95 14:43:32 INFO - 2016-01-18 14:43:32,893 DEBUG : BROWSER_OUTPUT: Values: 706.7 741.2 776.3 782.8 828.5 13423.5 13882.2 13890.0 13893.8 13898.9 13865.7 14246.0 14680.4 14684.6 14685.8 773.8 782.5 890.4 904.0 905.7 895.2 897.0 901.7 903.1 904.3 952.5 954.6 954.7 954.9 956.4 940.1 942.2 942.5 943.8 947.6 697.4 702.4 704.1 705.3 707.5 14170.8 14278.4 14285.7 14311.5 14314.4 11675.3 12010.8 12028.0 12223.3 12268.8 9952.9 10017.7 10051.8 10060.7 10071.7 3308.0 3359.0 3360.7 3364.8 3369.6 49109.0 49150.0 49170.3 51324.0 54115.2 9503.0 9621.3 9622.5 9653.3 9658.3 20792.4 20856.6 20879.6 20934.7 20937.4 7118.6 7172.9 7225.8 7307.3 7312.1 4141.9 4157.3 4162.8 4206.9 4218.4 3026.0 3056.5 3058.9 3059.2 3059.9 457.8 467.9 473.7 473.9 475.5 495.8 529.2 545.8 559.2 650.1 8069.1 8478.2 8498.6 8701.2 8719.5 528.0 538.5 556.4 579.2 639.4 3700.7 3860.7 3864.8 3987.7 3988.3 67752.0 69258.0 69295.0 69441.7 69689.7 59259.0 59951.4 60237.7 60305.1 60385.0 54975.0 55088.7 55301.0 55990.2 56259.7 7945.8 7970.8 7977.8 7999.7 8190.1 38887.4 39327.4 40491.2 40498.0 41432.2 49393.5 53296.7 53504.0 54631.0 55331.4 7774.6 7787.7 8000.4 8080.4 8145.5 10912.9 11038.6 11157.3 11360.1 11469.0 9786.4 9887.5 9949.9 10032.7 10221.2 10921.5 11023.6 11058.4 11202.2 11472.8 9924.6 9986.4 10046.9 10047.4 10129.5 9207.8 9511.7 9933.0 9955.3 9992.9 8421.3 8441.3 8503.6 8568.1 8736.3 14:43:32 INFO - 2016-01-18 14:43:32,893 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:43:32 INFO - 2016-01-18 14:43:32,893 DEBUG : BROWSER_OUTPUT: 14:43:33 INFO - 2016-01-18 14:43:33,410 INFO : Browser exited with error code: 0 14:43:33 INFO - 2016-01-18 14:43:33,425 INFO : Completed test dromaeo_css (00:18:28) 14:43:33 INFO - 2016-01-18 14:43:33,426 INFO : Starting test kraken 14:43:33 INFO - 2016-01-18 14:43:33,426 DEBUG : operating with platform_type : linux_ 14:43:33 INFO - 2016-01-18 14:43:33,426 INFO : Initialising browser for kraken test... 14:43:33 INFO - 2016-01-18 14:43:33,432 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpX99b9R/profile http://localhost:50905/getInfo.html 14:43:36 INFO - 2016-01-18 14:43:36,802 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:43:36 INFO - 2016-01-18 14:43:36,802 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:43:36 INFO - 2016-01-18 14:43:36,802 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 14:43:36 INFO - 2016-01-18 14:43:36,802 DEBUG : BROWSER_OUTPUT: __metrics 14:43:36 INFO - 2016-01-18 14:43:36,963 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] 14:43:38 INFO - 2016-01-18 14:43:38,110 INFO : Browser initialized. 14:43:38 INFO - 2016-01-18 14:43:38,110 INFO : Running cycle 1/1 for kraken test... 14:43:38 INFO - 2016-01-18 14:43:38,111 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpX99b9R/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:43:49 INFO - 2016-01-18 14:43:49,655 DEBUG : BROWSER_OUTPUT: RSS: Main: 128806912 14:43:49 INFO - 2016-01-18 14:43:49,655 DEBUG : BROWSER_OUTPUT: 14:43:52 INFO - 2016-01-18 14:43:52,096 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50905/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50905/tests/kraken/driver.html?testName=audio-beat-detection) 14:43:52 INFO - 2016-01-18 14:43:52,662 DEBUG : BROWSER_OUTPUT: RSS: Main: 162856960 14:43:52 INFO - 2016-01-18 14:43:52,662 DEBUG : BROWSER_OUTPUT: 14:43:55 INFO - 2016-01-18 14:43:55,224 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50905/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50905/tests/kraken/driver.html?testName=audio-dft) 14:43:55 INFO - 2016-01-18 14:43:55,790 DEBUG : BROWSER_OUTPUT: RSS: Main: 159539200 14:43:55 INFO - 2016-01-18 14:43:55,790 DEBUG : BROWSER_OUTPUT: 14:43:58 INFO - 2016-01-18 14:43:58,567 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50905/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50905/tests/kraken/driver.html?testName=audio-fft) 14:43:59 INFO - 2016-01-18 14:43:59,129 DEBUG : BROWSER_OUTPUT: RSS: Main: 157347840 14:43:59 INFO - 2016-01-18 14:43:59,129 DEBUG : BROWSER_OUTPUT: 14:44:01 INFO - 2016-01-18 14:44:01,082 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50905/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50905/tests/kraken/driver.html?testName=audio-oscillator) 14:44:01 INFO - 2016-01-18 14:44:01,643 DEBUG : BROWSER_OUTPUT: RSS: Main: 157384704 14:44:01 INFO - 2016-01-18 14:44:01,643 DEBUG : BROWSER_OUTPUT: 14:44:03 INFO - 2016-01-18 14:44:03,788 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50905/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50905/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:44:04 INFO - 2016-01-18 14:44:04,350 DEBUG : BROWSER_OUTPUT: RSS: Main: 155557888 14:44:04 INFO - 2016-01-18 14:44:04,350 DEBUG : BROWSER_OUTPUT: 14:44:07 INFO - 2016-01-18 14:44:07,217 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50905/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50905/tests/kraken/driver.html?testName=imaging-darkroom) 14:44:07 INFO - 2016-01-18 14:44:07,782 DEBUG : BROWSER_OUTPUT: RSS: Main: 155082752 14:44:07 INFO - 2016-01-18 14:44:07,782 DEBUG : BROWSER_OUTPUT: 14:44:11 INFO - 2016-01-18 14:44:11,130 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50905/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50905/tests/kraken/driver.html?testName=imaging-desaturate) 14:44:11 INFO - 2016-01-18 14:44:11,696 DEBUG : BROWSER_OUTPUT: RSS: Main: 157220864 14:44:11 INFO - 2016-01-18 14:44:11,696 DEBUG : BROWSER_OUTPUT: 14:44:14 INFO - 2016-01-18 14:44:14,398 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50905/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50905/tests/kraken/driver.html?testName=json-parse-financial) 14:44:14 INFO - 2016-01-18 14:44:14,972 DEBUG : BROWSER_OUTPUT: RSS: Main: 155312128 14:44:14 INFO - 2016-01-18 14:44:14,972 DEBUG : BROWSER_OUTPUT: 14:44:16 INFO - 2016-01-18 14:44:16,523 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50905/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50905/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:44:17 INFO - 2016-01-18 14:44:17,091 DEBUG : BROWSER_OUTPUT: RSS: Main: 160174080 14:44:17 INFO - 2016-01-18 14:44:17,091 DEBUG : BROWSER_OUTPUT: 14:44:18 INFO - 2016-01-18 14:44:18,841 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50905/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50905/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:44:19 INFO - 2016-01-18 14:44:19,431 DEBUG : BROWSER_OUTPUT: RSS: Main: 157196288 14:44:19 INFO - 2016-01-18 14:44:19,432 DEBUG : BROWSER_OUTPUT: 14:44:21 INFO - 2016-01-18 14:44:21,390 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50905/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50905/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:44:21 INFO - 2016-01-18 14:44:21,958 DEBUG : BROWSER_OUTPUT: RSS: Main: 164040704 14:44:21 INFO - 2016-01-18 14:44:21,958 DEBUG : BROWSER_OUTPUT: 14:44:24 INFO - 2016-01-18 14:44:24,273 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50905/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50905/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:44:24 INFO - 2016-01-18 14:44:24,856 DEBUG : BROWSER_OUTPUT: RSS: Main: 168058880 14:44:24 INFO - 2016-01-18 14:44:24,856 DEBUG : BROWSER_OUTPUT: 14:44:27 INFO - 2016-01-18 14:44:27,255 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50905/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50905/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:44:27 INFO - 2016-01-18 14:44:27,829 DEBUG : BROWSER_OUTPUT: RSS: Main: 165498880 14:44:27 INFO - 2016-01-18 14:44:27,829 DEBUG : BROWSER_OUTPUT: 14:44:29 INFO - 2016-01-18 14:44:29,444 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50905/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50905/tests/kraken/driver.html?testName=ai-astar) 14:44:29 INFO - 2016-01-18 14:44:29,694 DEBUG : BROWSER_OUTPUT: RSS: Main: 225157120 14:44:29 INFO - 2016-01-18 14:44:29,694 DEBUG : BROWSER_OUTPUT: 14:44:29 INFO - 2016-01-18 14:44:29,695 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:44:29 INFO - 2016-01-18 14:44:29,695 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:44:29 INFO - 2016-01-18 14:44:29,695 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:44:29 INFO - 2016-01-18 14:44:29,696 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:44:29 INFO - 2016-01-18 14:44:29,696 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;109;105;110;109;109;102;111;106;110 14:44:29 INFO - 2016-01-18 14:44:29,696 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;150;128;149;167;123;152;150;122;159;122 14:44:29 INFO - 2016-01-18 14:44:29,696 DEBUG : BROWSER_OUTPUT: |2;audio-dft;159;161;160;160;160;160;162;163;161;160 14:44:29 INFO - 2016-01-18 14:44:29,696 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;71;72;138;71;71;77;72;163;71 14:44:29 INFO - 2016-01-18 14:44:29,696 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;90;89;132;90;90;90;143;89;90;134 14:44:29 INFO - 2016-01-18 14:44:29,696 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;109;109;109;109;109;109;111;109 14:44:29 INFO - 2016-01-18 14:44:29,696 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;145;145;146;145;147;145;145;146;145 14:44:29 INFO - 2016-01-18 14:44:29,696 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;96;95;95;95;96;96;96 14:44:29 INFO - 2016-01-18 14:44:29,697 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;54;56;55;55;64;54;56;55;53;53 14:44:29 INFO - 2016-01-18 14:44:29,697 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;62;64;63;63;63;63;63;63;64;63 14:44:29 INFO - 2016-01-18 14:44:29,697 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;77;79;78;78;93;78;77;78;78;78 14:44:29 INFO - 2016-01-18 14:44:29,697 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;111;116;115;113;124;110;114;111;110;110 14:44:29 INFO - 2016-01-18 14:44:29,697 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;136;139;135;139;126;128;125;141;135;136 14:44:29 INFO - 2016-01-18 14:44:29,697 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;60;62;62;62;64;61;61;62;61;61 14:44:29 INFO - 2016-01-18 14:44:29,697 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:44:29 INFO - 2016-01-18 14:44:29,697 DEBUG : BROWSER_OUTPUT: __start_cc_report 14:44:29 INFO - 2016-01-18 14:44:29,697 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,872 14:44:29 INFO - 2016-01-18 14:44:29,697 DEBUG : BROWSER_OUTPUT: __end_cc_report 14:44:29 INFO - 2016-01-18 14:44:29,698 DEBUG : BROWSER_OUTPUT: __startTimestamp1453157069694__endTimestamp 14:44:29 INFO - 2016-01-18 14:44:29,698 DEBUG : BROWSER_OUTPUT: 14:44:29 INFO - 2016-01-18 14:44:29,701 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:44:29 INFO - 2016-01-18 14:44:29,701 DEBUG : BROWSER_OUTPUT: Number of tests: 14 14:44:29 INFO - 2016-01-18 14:44:29,701 DEBUG : BROWSER_OUTPUT: 14:44:29 INFO - 2016-01-18 14:44:29,701 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.10 Median:109.50 stddev:2.85 (2.6%) stddev-sans-first:2.93 14:44:29 INFO - 2016-01-18 14:44:29,701 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 105.0 110.0 109.0 109.0 102.0 111.0 106.0 110.0 14:44:29 INFO - 2016-01-18 14:44:29,701 DEBUG : BROWSER_OUTPUT: 14:44:29 INFO - 2016-01-18 14:44:29,701 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:142.20 Median:150.00 stddev:16.82 (11.2%) stddev-sans-first:17.61 14:44:29 INFO - 2016-01-18 14:44:29,701 DEBUG : BROWSER_OUTPUT: Values: 150.0 128.0 149.0 167.0 123.0 152.0 150.0 122.0 159.0 122.0 14:44:29 INFO - 2016-01-18 14:44:29,701 DEBUG : BROWSER_OUTPUT: 14:44:29 INFO - 2016-01-18 14:44:29,701 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.60 Median:160.50 stddev:1.17 (0.7%) stddev-sans-first:1.09 14:44:29 INFO - 2016-01-18 14:44:29,702 DEBUG : BROWSER_OUTPUT: Values: 159.0 161.0 160.0 160.0 160.0 160.0 162.0 163.0 161.0 160.0 14:44:29 INFO - 2016-01-18 14:44:29,702 DEBUG : BROWSER_OUTPUT: 14:44:29 INFO - 2016-01-18 14:44:29,702 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:87.80 Median:71.50 stddev:33.61 (47.0%) stddev-sans-first:35.16 14:44:29 INFO - 2016-01-18 14:44:29,702 DEBUG : BROWSER_OUTPUT: Values: 72.0 71.0 72.0 138.0 71.0 71.0 77.0 72.0 163.0 71.0 14:44:29 INFO - 2016-01-18 14:44:29,702 DEBUG : BROWSER_OUTPUT: 14:44:29 INFO - 2016-01-18 14:44:29,702 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:103.70 Median:90.00 stddev:22.69 (25.2%) stddev-sans-first:23.52 14:44:29 INFO - 2016-01-18 14:44:29,702 DEBUG : BROWSER_OUTPUT: Values: 90.0 89.0 132.0 90.0 90.0 90.0 143.0 89.0 90.0 134.0 14:44:29 INFO - 2016-01-18 14:44:29,702 DEBUG : BROWSER_OUTPUT: 14:44:29 INFO - 2016-01-18 14:44:29,703 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 14:44:29 INFO - 2016-01-18 14:44:29,703 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 109.0 109.0 109.0 109.0 109.0 109.0 111.0 109.0 14:44:29 INFO - 2016-01-18 14:44:29,703 DEBUG : BROWSER_OUTPUT: 14:44:29 INFO - 2016-01-18 14:44:29,703 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 14:44:29 INFO - 2016-01-18 14:44:29,703 DEBUG : BROWSER_OUTPUT: Values: 145.0 145.0 145.0 146.0 145.0 147.0 145.0 145.0 146.0 145.0 14:44:29 INFO - 2016-01-18 14:44:29,703 DEBUG : BROWSER_OUTPUT: 14:44:29 INFO - 2016-01-18 14:44:29,703 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 14:44:29 INFO - 2016-01-18 14:44:29,703 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 96.0 95.0 95.0 95.0 96.0 96.0 96.0 14:44:29 INFO - 2016-01-18 14:44:29,704 DEBUG : BROWSER_OUTPUT: 14:44:29 INFO - 2016-01-18 14:44:29,704 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:55.50 Median:55.00 stddev:3.17 (5.8%) stddev-sans-first:3.32 14:44:29 INFO - 2016-01-18 14:44:29,704 DEBUG : BROWSER_OUTPUT: Values: 54.0 56.0 55.0 55.0 64.0 54.0 56.0 55.0 53.0 53.0 14:44:29 INFO - 2016-01-18 14:44:29,704 DEBUG : BROWSER_OUTPUT: 14:44:29 INFO - 2016-01-18 14:44:29,704 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:63.10 Median:63.00 stddev:0.57 (0.9%) stddev-sans-first:0.44 14:44:29 INFO - 2016-01-18 14:44:29,704 DEBUG : BROWSER_OUTPUT: Values: 62.0 64.0 63.0 63.0 63.0 63.0 63.0 63.0 64.0 63.0 14:44:29 INFO - 2016-01-18 14:44:29,704 DEBUG : BROWSER_OUTPUT: 14:44:29 INFO - 2016-01-18 14:44:29,704 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:79.40 Median:78.00 stddev:4.81 (6.2%) stddev-sans-first:5.02 14:44:29 INFO - 2016-01-18 14:44:29,705 DEBUG : BROWSER_OUTPUT: Values: 77.0 79.0 78.0 78.0 93.0 78.0 77.0 78.0 78.0 78.0 14:44:29 INFO - 2016-01-18 14:44:29,705 DEBUG : BROWSER_OUTPUT: 14:44:29 INFO - 2016-01-18 14:44:29,705 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:113.40 Median:113.50 stddev:4.33 (3.8%) stddev-sans-first:4.50 14:44:29 INFO - 2016-01-18 14:44:29,705 DEBUG : BROWSER_OUTPUT: Values: 111.0 116.0 115.0 113.0 124.0 110.0 114.0 111.0 110.0 110.0 14:44:29 INFO - 2016-01-18 14:44:29,705 DEBUG : BROWSER_OUTPUT: 14:44:29 INFO - 2016-01-18 14:44:29,705 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:134.00 Median:136.00 stddev:5.68 (4.2%) stddev-sans-first:5.97 14:44:29 INFO - 2016-01-18 14:44:29,705 DEBUG : BROWSER_OUTPUT: Values: 136.0 139.0 135.0 139.0 126.0 128.0 125.0 141.0 135.0 136.0 14:44:29 INFO - 2016-01-18 14:44:29,706 DEBUG : BROWSER_OUTPUT: 14:44:29 INFO - 2016-01-18 14:44:29,706 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.60 Median:62.00 stddev:1.07 (1.7%) stddev-sans-first:0.97 14:44:29 INFO - 2016-01-18 14:44:29,706 DEBUG : BROWSER_OUTPUT: Values: 60.0 62.0 62.0 62.0 64.0 61.0 61.0 62.0 61.0 61.0 14:44:29 INFO - 2016-01-18 14:44:29,706 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:44:29 INFO - 2016-01-18 14:44:29,706 DEBUG : BROWSER_OUTPUT: 14:44:30 INFO - 2016-01-18 14:44:30,326 INFO : Browser exited with error code: 0 14:44:30 INFO - 2016-01-18 14:44:30,382 INFO : Completed test kraken (00:00:56) 14:44:30 INFO - 2016-01-18 14:44:30,382 INFO : Starting test v8_7 14:44:30 INFO - 2016-01-18 14:44:30,382 DEBUG : operating with platform_type : linux_ 14:44:30 INFO - 2016-01-18 14:44:30,382 INFO : Initialising browser for v8_7 test... 14:44:30 INFO - 2016-01-18 14:44:30,389 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSJlm5_/profile http://localhost:50905/getInfo.html 14:44:33 INFO - 2016-01-18 14:44:33,749 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:44:33 INFO - 2016-01-18 14:44:33,749 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:44:33 INFO - 2016-01-18 14:44:33,749 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 14:44:33 INFO - 2016-01-18 14:44:33,750 DEBUG : BROWSER_OUTPUT: __metrics 14:44:33 INFO - 2016-01-18 14:44:33,830 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] 14:44:35 INFO - 2016-01-18 14:44:35,045 INFO : Browser initialized. 14:44:35 INFO - 2016-01-18 14:44:35,046 INFO : Running cycle 1/1 for v8_7 test... 14:44:35 INFO - 2016-01-18 14:44:35,046 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSJlm5_/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:44:46 INFO - 2016-01-18 14:44:46,597 DEBUG : BROWSER_OUTPUT: RSS: Main: 128491520 14:44:46 INFO - 2016-01-18 14:44:46,597 DEBUG : BROWSER_OUTPUT: 14:45:07 INFO - 2016-01-18 14:45:07,985 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50905/tests/v8_7/run.html (next: http://localhost:50905/tests/v8_7/run.html) 14:45:08 INFO - 2016-01-18 14:45:08,236 DEBUG : BROWSER_OUTPUT: RSS: Main: 423108608 14:45:08 INFO - 2016-01-18 14:45:08,236 DEBUG : BROWSER_OUTPUT: 14:45:08 INFO - 2016-01-18 14:45:08,237 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:45:08 INFO - 2016-01-18 14:45:08,238 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:45:08 INFO - 2016-01-18 14:45:08,238 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:45:08 INFO - 2016-01-18 14:45:08,238 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:45:08 INFO - 2016-01-18 14:45:08,238 DEBUG : BROWSER_OUTPUT: |0;Richards;166.61112962345885 14:45:08 INFO - 2016-01-18 14:45:08,238 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;170.32873445750297 14:45:08 INFO - 2016-01-18 14:45:08,238 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.42624789680315 14:45:08 INFO - 2016-01-18 14:45:08,239 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5010 14:45:08 INFO - 2016-01-18 14:45:08,239 DEBUG : BROWSER_OUTPUT: |4;RayTrace;934.5794392523364 14:45:08 INFO - 2016-01-18 14:45:08,239 DEBUG : BROWSER_OUTPUT: |5;Earley;557.7244841048522 14:45:08 INFO - 2016-01-18 14:45:08,239 DEBUG : BROWSER_OUTPUT: |6;Boyer;10479.166666666666 14:45:08 INFO - 2016-01-18 14:45:08,239 DEBUG : BROWSER_OUTPUT: |7;RegExp;23418.60465116279 14:45:08 INFO - 2016-01-18 14:45:08,239 DEBUG : BROWSER_OUTPUT: |8;Splay;544.3658138268917 14:45:08 INFO - 2016-01-18 14:45:08,239 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 14:45:08 INFO - 2016-01-18 14:45:08,239 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:45:08 INFO - 2016-01-18 14:45:08,240 DEBUG : BROWSER_OUTPUT: __startTimestamp1453157108236__endTimestamp 14:45:08 INFO - 2016-01-18 14:45:08,240 DEBUG : BROWSER_OUTPUT: 14:45:08 INFO - 2016-01-18 14:45:08,240 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:45:08 INFO - 2016-01-18 14:45:08,240 DEBUG : BROWSER_OUTPUT: Number of tests: 10 14:45:08 INFO - 2016-01-18 14:45:08,240 DEBUG : BROWSER_OUTPUT: 14:45:08 INFO - 2016-01-18 14:45:08,240 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.61 Median:166.61 stddev:0.00 (0.0%) 14:45:08 INFO - 2016-01-18 14:45:08,240 DEBUG : BROWSER_OUTPUT: Values: 166.6 14:45:08 INFO - 2016-01-18 14:45:08,240 DEBUG : BROWSER_OUTPUT: 14:45:08 INFO - 2016-01-18 14:45:08,240 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:170.33 Median:170.33 stddev:0.00 (0.0%) 14:45:08 INFO - 2016-01-18 14:45:08,241 DEBUG : BROWSER_OUTPUT: Values: 170.3 14:45:08 INFO - 2016-01-18 14:45:08,242 DEBUG : BROWSER_OUTPUT: 14:45:08 INFO - 2016-01-18 14:45:08,242 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.43 Median:280.43 stddev:0.00 (0.0%) 14:45:08 INFO - 2016-01-18 14:45:08,242 DEBUG : BROWSER_OUTPUT: Values: 280.4 14:45:08 INFO - 2016-01-18 14:45:08,242 DEBUG : BROWSER_OUTPUT: 14:45:08 INFO - 2016-01-18 14:45:08,242 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5010.00 Median:5010.00 stddev:0.00 (0.0%) 14:45:08 INFO - 2016-01-18 14:45:08,242 DEBUG : BROWSER_OUTPUT: Values: 5010.0 14:45:08 INFO - 2016-01-18 14:45:08,242 DEBUG : BROWSER_OUTPUT: 14:45:08 INFO - 2016-01-18 14:45:08,242 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:934.58 Median:934.58 stddev:0.00 (0.0%) 14:45:08 INFO - 2016-01-18 14:45:08,242 DEBUG : BROWSER_OUTPUT: Values: 934.6 14:45:08 INFO - 2016-01-18 14:45:08,242 DEBUG : BROWSER_OUTPUT: 14:45:08 INFO - 2016-01-18 14:45:08,243 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:557.72 Median:557.72 stddev:0.00 (0.0%) 14:45:08 INFO - 2016-01-18 14:45:08,243 DEBUG : BROWSER_OUTPUT: Values: 557.7 14:45:08 INFO - 2016-01-18 14:45:08,243 DEBUG : BROWSER_OUTPUT: 14:45:08 INFO - 2016-01-18 14:45:08,243 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10479.17 Median:10479.17 stddev:0.00 (0.0%) 14:45:08 INFO - 2016-01-18 14:45:08,243 DEBUG : BROWSER_OUTPUT: Values: 10479.2 14:45:08 INFO - 2016-01-18 14:45:08,243 DEBUG : BROWSER_OUTPUT: 14:45:08 INFO - 2016-01-18 14:45:08,243 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:23418.60 Median:23418.60 stddev:0.00 (0.0%) 14:45:08 INFO - 2016-01-18 14:45:08,243 DEBUG : BROWSER_OUTPUT: Values: 23418.6 14:45:08 INFO - 2016-01-18 14:45:08,243 DEBUG : BROWSER_OUTPUT: 14:45:08 INFO - 2016-01-18 14:45:08,243 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:544.37 Median:544.37 stddev:0.00 (0.0%) 14:45:08 INFO - 2016-01-18 14:45:08,243 DEBUG : BROWSER_OUTPUT: Values: 544.4 14:45:08 INFO - 2016-01-18 14:45:08,244 DEBUG : BROWSER_OUTPUT: 14:45:08 INFO - 2016-01-18 14:45:08,244 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 14:45:08 INFO - 2016-01-18 14:45:08,244 DEBUG : BROWSER_OUTPUT: Values: 4835.7 14:45:08 INFO - 2016-01-18 14:45:08,244 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:45:08 INFO - 2016-01-18 14:45:08,244 DEBUG : BROWSER_OUTPUT: 14:45:08 INFO - 2016-01-18 14:45:08,862 INFO : Browser exited with error code: 0 14:45:08 INFO - 2016-01-18 14:45:08,878 INFO : Completed test v8_7 (00:00:38) 14:45:09 INFO - 2016-01-18 14:45:09,247 INFO : Completed test suite (00:20:04) 14:45:09 INFO - 2016-01-18 14:45:09,247 DEBUG : Working with test: dromaeo_css 14:45:09 INFO - 2016-01-18 14:45:09,247 DEBUG : Generating results file: dromaeo_css 14:45:09 INFO - 2016-01-18 14:45:09,248 DEBUG : Working with test: kraken 14:45:09 INFO - 2016-01-18 14:45:09,248 DEBUG : Generating results file: kraken 14:45:09 INFO - 2016-01-18 14:45:09,248 INFO : javascript benchmark 14:45:09 INFO - 2016-01-18 14:45:09,249 DEBUG : Working with test: v8_7 14:45:09 INFO - 2016-01-18 14:45:09,249 DEBUG : Generating results file: v8_7 14:45:09 INFO - 2016-01-18 14:45:09,249 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:45:09 INFO - 2016-01-18 14:45:09,418 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,53,35]] 14:45:09 INFO - 2016-01-18 14:45:09,419 DEBUG : process_Request line: dromaeo_css 7100.36 graph.html#tests=[[72,53,35]] 14:45:09 INFO - 2016-01-18 14:45:09,419 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:45:09 INFO - 2016-01-18 14:45:09,555 DEBUG : process_Request line: kraken 1459.60 graph.html#tests=[[232,53,35]] 14:45:09 INFO - 2016-01-18 14:45:09,555 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:45:09 INFO - 2016-01-18 14:45:09,698 DEBUG : process_Request line: v8_7 23256.68 graph.html#tests=[[230,53,35]] 14:45:09 INFO - 2016-01-18 14:45:09,699 INFO : javascript benchmark 14:45:09 INFO - 2016-01-18 14:45:09,703 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3308.7353011759055, 3344.5819272590925, 3375.8143302118388, 3381.7125544328715, 3396.3037577296654, 5538.6399884007515, 5549.472800083986, 5557.555395568355, 5557.7776888924445, 5576.414476479972, 5573.637713548616, 5587.525060369863, 5590.161475778636, 5597.384287728357, 5599.160125981105, 4945.826896058638, 5073.873153171182, 5098.337216161913, 5162.277281180638, 5217.556507696831, 4987.800487980477, 4988.725620090893, 5043.823466178685, 5049.772760225798, 5076.8730781730565, 5126.846194614168, 5151.4075881273575, 5158.380994280692, 5191.0656081905245, 5204.34945631796, 4987.077390682735, 5101.464346243665, 5105.463926287724, 5144.56271216947, 5182.222666600002, 4977.576905962997, 4992.176290911995, 5044.344235249394, 5049.873753156164, 5061.5950723942, 5363.302770639831, 5416.025115479212, 5445.237666726662, 5453.018456677796, 5485.6434331768305, 5965.0, 6075.665838378887, 6086.315012910367, 6086.726097325631, 6095.512359011268, 5938.792142275, 6001.48987336077, 6006.0, 6011.12838638395, 6023.45788879003, 5601.215829783833, 5684.261046063985, 5686.0333743263745, 5686.14707793826, 5694.430556944314, 5975.790847320323, 6053.545984051214, 6080.452759251689, 6099.420555047263, 6106.755729770848, 5973.850653733692, 5977.043673012384, 5981.970090149522, 5985.132155837467, 5987.161797348374, 6069.3627169147485, 6070.998285282879, 6075.149479072933, 6080.179175811209, 6080.695965201722, 5761.683107429131, 5860.619059761102, 6037.879242415127, 6057.3336932937345, 6114.4062736356245, 6006.969965150233, 6010.759569617254, 6011.368806275365, 6014.849628759229, 6023.6385816851125, 4605.6085232755595, 4605.677602567788, 4608.124456353282, 4610.3084537319, 4634.791434385461, 4012.498437695288, 4036.273470775289, 4091.8363265469047, 4115.8971025723995, 4117.464729585135, 5684.8294551163535, 5718.370979192286, 5724.255846739898, 5729.684867332337, 5743.195952566644, 5861.296644402613, 6072.666003369857, 6075.2405949256345, 6086.786962456293, 6100.176476175749, 5601.383847776741, 5613.7193140342815, 5645.689487078168, 5665.3768085510565, 5689.516391106719, 5246.921296180561, 5299.761510731949, 5302.92045619316, 5308.575313974873, 5309.044372012998, 5992.0712289595185, 6069.089636554552, 6247.0, 6270.059491076375, 6287.088372186007, 5948.7323070461935, 6035.728392222272, 6036.9094463582205, 6047.455728984412, 6075.27096748393, 6100.481459076028, 6269.467095296951, 6292.716827742855, 6302.747890084345, 6330.651814150082, 5727.68497732612, 5877.059670452707, 5931.881362372642, 6054.75780968774, 6067.150598916243, 6130.873254640076, 6144.508439324753, 6145.0782382642965, 6150.169727086965, 6156.045812899008, 5974.701264936649, 5977.521798256216, 5981.790637327673, 5986.2517185351835, 5993.340732519507, 5725.570582206268, 5808.15781711641, 5825.883482330414, 5940.376260492586, 5958.285005799332, 5770.394108618535, 5774.0761478163295, 5775.0, 5795.536357091507, 5829.387914268941, 5817.301923769175, 5864.706764661664, 5879.676617785892, 5924.674142922181, 5930.881382372242, 5652.463016013472, 5660.490555849993, 5685.658860468385, 5765.423457654201, 5875.6474611523445], "unit": "ms", "name": "dojo.html", "value": 5544.742483111008}, {"lowerIsBetter": false, "replicates": [585.4935480809102, 642.7653906324192, 643.0836058616471, 652.794369773521, 658.8319978405503, 36351.272974540494, 44641.0, 45210.321845172264, 45235.321470177936, 45272.3209151863, 49249.55253132282, 49749.25376119352, 49874.251886221646, 49896.50103498964, 49900.75049624756, 8351.791205219888, 8454.830903381928, 9240.676576319847, 9337.206337461324, 10684.679459616224, 10857.185711071661, 10961.0, 10962.068224200952, 10995.175361847854, 11012.063974562172, 10951.780964380707, 11052.613158539452, 11067.114630829514, 11068.446577671124, 11069.280496767724, 8557.786055348604, 8741.0, 10971.396573188471, 11292.717682057932, 11296.209265351428, 10853.5115919783, 10994.945025274903, 10995.285306455135, 10995.505202265836, 11006.834897476545, 45375.31937020947, 45997.310040349425, 46041.53958460406, 46047.53952460466, 46079.0, 3334.7665663403573, 3569.1790888095884, 3626.582942961567, 3705.40713485841, 3734.309152806712, 33993.6600633993, 34444.0, 34472.31055378878, 34495.31009379798, 34523.30953380918, 3339.96660033399, 3375.1562109472634, 3387.6104248011547, 3481.2863363010774, 3491.14466955595, 329042.0, 330291.0, 330379.0, 330863.0, 331079.0, 72190.2780972194, 72518.63740681263, 72575.0, 72632.63683681548, 72736.0, 76684.23315766883, 77187.0, 77292.61353693307, 77315.0, 77419.61290193514, 17249.39627113045, 17501.912490437466, 17593.91203044002, 17670.82329176692, 17690.380836670913, 13495.730085398238, 13528.0, 13539.255340956144, 13569.389377478037, 13574.59276221715, 23033.654495182585, 23325.53348933012, 23441.7655823443, 23445.296641100795, 23472.0, 8549.529775862387, 8744.519051452231, 8870.467771933705, 8958.10418958099, 8988.370814042953, 986.8026394721085, 1045.6078970386104, 1057.6525297433536, 1116.4083035990939, 1145.7078444996473, 31578.36843263168, 31995.0, 32312.35375292528, 34507.65492345044, 35183.824080879946, 1045.72288343589, 1070.8340207267886, 1144.2162118948547, 1161.5818305410046, 1194.0328334049448, 14864.925675371771, 16770.74843877343, 16930.238139283763, 16941.06824124685, 17246.65506689859, 296665.0, 299568.0, 299929.0, 299951.0, 300197.0, 57103.71448142733, 57369.13946290809, 57459.0, 57488.425115749145, 57648.42351576514, 1488.8287846897529, 1494.3873012065, 1509.3434356055152, 1516.780066890317, 1518.855708707671, 30035.69964300329, 30147.69852301449, 31656.841715791274, 31750.364992699553, 32686.34627307393, 57374.42625573691, 59156.70421647864, 59198.04009799407, 59243.40756592551, 59445.405545943984, 243756.0, 244505.0, 245113.0, 245355.0, 245834.0, 31950.201244969063, 32398.51402228921, 35513.64486355103, 35949.1012724684, 36916.261674766894, 44750.552494474636, 45282.0, 45459.31811022771, 45872.0, 45908.311375328725, 38010.61989380071, 38122.809385952896, 38219.42670859995, 38387.0, 39289.60710392974, 38210.235795283385, 40210.0, 41004.0, 41153.38269925894, 42260.0, 35877.82061089678, 41032.79483602563, 41610.37584436296, 41673.0, 42277.15445691007, 33867.49198761971, 35828.462573061945, 35964.280714385044, 36248.27503449969, 37633.81183094067, 25785.355366115997, 26473.470530588897, 27363.33973986492, 28211.2947176314, 28257.293567660974], "unit": "ms", "name": "ext.html", "value": 20666.071688698576}, {"lowerIsBetter": false, "replicates": [370.6756587985513, 373.21438372226464, 385.96912247020225, 387.0126898376834, 387.0594455473201, 17640.0, 19850.801491985076, 20169.495762605904, 20315.695264571026, 20340.0, 18356.81643183568, 18443.17005734742, 18542.90728546359, 18650.906745466287, 19021.809781902175, 5645.774169033234, 5766.365699773021, 5773.971130144343, 5777.480026797598, 5778.6243894146955, 5669.319681638209, 5696.829095127132, 5746.0806270996645, 5748.0, 5757.625754325976, 4319.69762116652, 4457.799399027052, 5684.857878553028, 5701.828945131652, 5711.628744131639, 5984.940150598503, 6126.111713801519, 6168.784092556739, 6169.907451388232, 6191.318954914956, 4400.229959757062, 4469.888252793674, 4483.08096840147, 5406.216098665711, 5410.3507579090365, 14623.122612643276, 14726.0, 14814.629634259121, 14838.70322593542, 14853.2573371331, 2008.1967213114724, 2097.6958341040463, 2141.7108690326763, 2148.398448434441, 2239.7648246934, 10423.739406514822, 10477.26659133861, 10485.370877747284, 10492.895071049345, 10513.684589462327, 1686.1569215392303, 1694.3730819596828, 1717.6135369541878, 1756.3150371355182, 1769.0889192066097, 63678.68160659167, 65697.67151164262, 65860.67069664669, 65935.0, 65977.34022659808, 7830.804229894185, 7884.0, 7917.524948503108, 7960.880586791202, 7973.800654983672, 9558.665446709332, 9574.0, 9577.0, 9577.090176433228, 9580.0898914603, 6060.33336333003, 6094.0, 6122.571420000557, 6123.142760013601, 6153.8461538461, 6153.600015998945, 6168.599041062316, 6179.16581261524, 6248.062790581449, 6328.208973878265, 3580.0, 3667.468217108504, 3668.2663467306647, 3690.391085470921, 3693.1874987502706, 1252.4426630149496, 1254.4731212890608, 1254.9686257843443, 1260.3257257367266, 1285.1710646632869, 435.18185810675726, 506.82261208576705, 511.0, 555.7832445346318, 567.9744411501492, 12642.620721378373, 12711.61865144047, 13068.346582670829, 13080.672983175496, 13086.672833179247, 533.7998250656004, 537.3712756075402, 556.7800718716085, 562.831150654802, 572.0561074227558, 7055.0, 7132.393746531603, 7276.272372762682, 7299.744508942162, 7303.194274742559, 647634.0, 647636.0, 658086.0, 670310.0, 675688.0, 61440.69279653663, 72264.91602625964, 74813.0, 75050.0, 76228.61885690536, 592.7362323765883, 608.7747533412665, 609.6007115339548, 610.8167549735061, 610.9266887973472, 11656.76686466249, 11909.821352679543, 12021.75956480883, 12084.093692972887, 12135.02919766399, 34458.0, 34567.308653827284, 34629.65370346365, 36062.819685901406, 36529.26941461209, 46432.0, 47142.76428617972, 51563.22655160251, 52678.73660631672, 53910.46089539054, 7381.26187381279, 7560.886586701094, 7580.62096895142, 7586.582737949466, 7592.202818703957, 13254.801177982145, 13256.933715331748, 13347.199168049949, 13547.187168769906, 13636.181829090287, 11308.49111789955, 11468.598599048993, 11559.190856639954, 11904.58333958342, 11947.163698541019, 2633.9341516461477, 3988.720789544704, 7466.954626352206, 11685.76628467443, 12080.39598020113, 11747.353895535827, 11774.0, 11845.644630661094, 12440.937795311327, 12467.75064498723, 7665.6933722650465, 7728.92271077282, 7755.3407960324, 7757.806054848448, 7759.2240775921955, 11974.0, 12131.575394861138, 12302.138850280753, 12304.0, 12480.375981200723], "unit": "ms", "name": "jquery.html", "value": 7625.100489152625}, {"lowerIsBetter": false, "replicates": [1577.723898317795, 1580.344157174772, 1789.337944960365, 1872.7378167056615, 1880.2385034061206, 7355.3012463815985, 7453.254674532544, 7778.961105194473, 7958.522488650685, 7971.800704982378, 7911.129775724666, 8019.839603207933, 8088.67645294189, 8100.716474923379, 8110.797230069251, 2376.6435034744754, 2413.2880800163994, 2418.89114989825, 2418.9153379631716, 2419.2742177346727, 2135.893205339735, 2181.6291230490856, 2340.602097643396, 2395.628677554973, 2399.36416849535, 2284.440312123532, 2286.576983258094, 2287.839851210416, 2289.2788771537, 2298.655201719747, 2427.7936375408112, 2451.3381387025493, 2453.031052734178, 2453.595156799135, 2454.619533972237, 2403.8557686538866, 2458.6680798092207, 2461.3477428481287, 2464.0759715106833, 2464.1745015419856, 8237.299829514499, 8290.41967062306, 8305.044919834236, 8316.501009939422, 8317.750467485985, 5012.323336349619, 5074.847754567369, 5089.618278629117, 5089.643724939256, 5091.87270318245, 3171.4767063434506, 3180.3003339265324, 3274.9017529474154, 3278.6721327867263, 3295.20914980403, 1052.4842827014784, 1055.72551136705, 1071.212658695858, 1073.4595854948097, 1082.5290998415635, 11393.373364464951, 11397.373144477051, 11409.0, 11411.201215914889, 11421.371824549646, 4626.1210370029585, 4629.722216667011, 4677.22825733757, 4694.600958918462, 4709.222978208557, 9820.754481138028, 9853.655122070693, 9866.851997220047, 9881.25890558211, 9885.357451765612, 5097.796088156507, 5107.591392688576, 5109.744512774347, 5115.386153661584, 5115.87210319745, 4644.535546445329, 4650.0, 4656.906861862743, 4661.906761864744, 4664.043871006435, 3504.5268888700207, 3976.0855003348815, 4002.479677641888, 4027.7986100694848, 4043.7775922323967, 1238.6036468330049, 1242.726600147966, 1282.3075539208724, 1284.6531436512275, 1291.599604122725, 1174.2191442690687, 1183.9822402663967, 1184.08233618946, 1187.8990285825628, 1332.9400176992058, 7875.527468351917, 7883.2116788321855, 7918.366530677532, 7947.562884041433, 7993.080795708452, 1201.9663089742814, 1280.6798300424894, 1299.493197652916, 1306.9019823513274, 1316.9539066132638, 6295.622262664255, 6338.0, 6342.143810585604, 6343.333949935282, 6359.491240700733, 9603.231741460666, 10184.541695623715, 10189.847152292721, 10209.846852297222, 10218.540165692562, 9924.007599240018, 10047.648332308334, 10067.093961543496, 10074.647387341407, 10086.546105425274, 7855.921440785633, 7969.760907172794, 7987.241212084843, 7994.920050799534, 7997.640106195236, 7573.886391704239, 7585.469017168966, 7648.80877978055, 7665.3101220890385, 7671.462997590338, 8884.644614215358, 8925.73222803317, 8962.0, 8979.326550508607, 9179.954100229723, 9209.401388909699, 9289.581968811284, 9307.86038209441, 9313.860292095489, 9410.952945235504, 6929.168499779857, 6982.33667801558, 6982.546134501241, 6994.9300506996315, 7002.474814388839, 6966.79099627012, 7382.9261707384385, 7767.495112817649, 7772.106207786177, 7920.405969552191, 7323.194448610755, 7362.77911662651, 7433.8141546461775, 7539.509931854412, 7676.846463070819, 7241.0, 7311.232320606472, 7323.2676732326345, 7380.96309518449, 7421.146568144733, 7457.2542745724995, 7617.961910190414, 7618.200088990798, 7624.085109786861, 7644.235576442311, 6899.103116594811, 6930.5148639594745, 6931.0643063187845, 6932.306769323028, 6936.4797640176175, 6954.826129346807, 6994.33553812387, 6995.860082798417, 6999.0, 6999.195092564217], "unit": "ms", "name": "mootools.html", "value": 4791.6229260463615}, {"lowerIsBetter": false, "replicates": [362.99092522686936, 366.93578623740837, 368.0577721034151, 370.83312509370774, 376.8624452074993, 5916.970415147918, 5957.0, 5979.551533634973, 5990.910136347953, 5999.850003749903, 5849.707514624273, 5927.8221653350365, 5936.376680448556, 5940.405959404057, 5942.544076701203, 4660.0, 4661.3241080043545, 4664.906701865961, 4668.25307950728, 4669.976650116745, 4500.639948804088, 4563.7489938053395, 4590.862274131765, 4668.626509879218, 4680.695754775946, 4620.099080679269, 4620.768961551926, 4623.5838774510285, 4642.048380082075, 4646.697964632305, 4609.792559334838, 4613.284940834176, 4613.723176609381, 4621.838235661752, 4632.791524381377, 4123.134141830219, 4126.628603425676, 4127.40152677863, 4129.174165166949, 4130.256553820311, 5560.388357280696, 5577.3028371453565, 5623.915641265385, 5636.605437619368, 5671.51792097668, 5326.547243484309, 5335.1997200419855, 5360.544353729938, 5367.0339338918975, 5369.892602147936, 6026.789062382795, 6221.688915554249, 6222.191115155001, 6223.315435302113, 6234.812955611339, 4379.671524635665, 4416.116776644684, 4418.447694038246, 4454.265046267362, 4467.642588592905, 6428.485721142344, 6433.453156481704, 6451.645159516272, 6454.741810327581, 6461.450776683941, 4552.908941821212, 4558.49856515783, 4558.658100642465, 4560.543945605479, 4561.29299958507, 4538.410006699174, 4613.95386046142, 4615.538446155358, 4677.859664210079, 4682.016776476978, 5353.4646535346155, 5356.892862142735, 5358.115910874662, 5361.758720857571, 5363.678179309254, 6400.23197216337, 6402.551821372553, 6404.0, 6408.2630497492455, 6410.0, 1701.6171361443576, 1725.9299234474706, 1727.3522429089091, 1727.7322015087682, 1728.8184740602308, 1156.3986726901965, 1166.4984056855465, 1171.654361963206, 1172.9882701172878, 1214.0651698192341, 6198.845028874314, 6199.3490683478485, 6200.534959878028, 6204.317525072239, 6205.906911396332, 6552.246491653425, 6553.541252112402, 6559.819232538093, 6563.113979612786, 6593.472522198213, 6040.124181993674, 6156.569040167145, 6159.3224745277985, 6160.7535698571555, 6164.938350616526, 3589.4615807629066, 3623.2572322673786, 3629.564452265745, 3643.7267204959735, 3645.85416583339, 6712.328767123248, 6718.66406679664, 6735.326467353226, 6742.292059333798, 6749.93250067493, 6619.470442364599, 6714.9664251679405, 6717.193936727624, 6724.058631791553, 6724.966375168093, 6678.565893216925, 6698.933010669928, 6704.597724136567, 6712.496562757813, 6717.563358381787, 6370.490360771035, 6457.903131452938, 6518.869622607426, 6544.770933017321, 6572.901406478811, 6403.935960640334, 6448.258450278278, 6486.254080780582, 6486.805395838132, 6488.188976377953, 6639.502037347122, 6676.298988606321, 6676.566023208476, 6694.59832410057, 6704.76533321351, 4577.138241541147, 4631.305304204397, 4637.698549594401, 4640.095181439587, 4677.859664210079, 6582.605043697394, 6606.801795945937, 6611.900821487586, 6612.0, 6614.338566143347, 6404.327545607644, 6414.390632889868, 6423.582467139621, 6428.132202152837, 6438.8390290243115, 6328.810135695752, 6405.03924411342, 6405.135306733718, 6411.102445657705, 6413.038044293393, 6323.620582764865, 6323.956547169665, 6326.145970293951, 6331.05034244867, 6332.398422149889, 6463.062855885964, 6469.159009328945, 6470.7088181032905, 6475.384838440341, 6475.7733479328, 6228.937710623017, 6287.402696743802, 6321.589096708699, 6322.525810564134, 6323.494120470444], "unit": "ms", "name": "prototype.html", "value": 4847.988845827838}, {"lowerIsBetter": false, "replicates": [706.7385067525015, 741.2106106996052, 776.3401109057302, 782.8434313137374, 828.5012382761602, 13423.530176443826, 13882.236476993761, 13890.0, 13893.791593126098, 13898.861011389883, 13865.653358666039, 14246.0, 14680.412783488648, 14684.632884177901, 14685.825133989281, 773.760134358348, 782.4561929459028, 890.4167770110572, 903.9728808135767, 905.678484138128, 895.2166854002747, 897.0222457521301, 901.6708901251029, 903.069838066789, 904.3036861616552, 952.5427794658568, 954.627695198873, 954.7422196007074, 954.937929034614, 956.3687965942479, 940.1256831147031, 942.203837757101, 942.4957647658538, 943.8065196634708, 947.5735918836517, 697.4246246846373, 702.4099756204813, 704.105785652224, 705.2947052947053, 707.4835370179798, 14170.787438188436, 14278.428862845474, 14285.714285714228, 14311.499097531536, 14314.42742290307, 11675.299482031105, 12010.759784804342, 12028.0, 12223.266604003788, 12268.754624907451, 9952.850707239397, 10017.749556261078, 10051.798964020678, 10060.69817905464, 10071.69784906454, 3307.9503807442907, 3358.958722795941, 3360.6807353301397, 3364.8317584120696, 3369.629340772513, 49109.0, 49150.0, 49170.26244606334, 51324.0, 54115.18827217595, 9502.952485237529, 9621.326507144573, 9622.51887405627, 9653.276004299705, 9658.323917325719, 20792.37622871316, 20856.58286834255, 20879.582408351747, 20934.685979710317, 20937.37187884366, 7118.644067796589, 7172.892406613905, 7225.819354516179, 7307.342339189392, 7312.085989251344, 4141.91716165681, 4157.293260145782, 4162.771047592351, 4206.894827629334, 4218.430511880918, 3026.0, 3056.480398332289, 3058.8776448941794, 3059.174023013774, 3059.9235019124253, 457.76425141052385, 467.8900458392275, 473.70630209269785, 473.8838984448763, 475.46985111600316, 495.76946719775475, 529.1718460609135, 545.8007827143064, 559.1891756952435, 650.0898741761572, 8069.072056713436, 8478.152184781473, 8498.575071246412, 8701.17338852808, 8719.520426376483, 527.9841604751787, 538.496505767109, 556.3824155187739, 579.1775678536488, 639.3766078073841, 3700.7224458165206, 3860.6911447084167, 3864.8454061837774, 3987.6809855211513, 3988.3020471417967, 67752.0, 69258.0, 69295.0, 69441.65279173572, 69689.65155174192, 59259.0, 59951.400485994585, 60237.69881150566, 60305.09542356868, 60385.0, 54975.0, 55088.72455637776, 55301.0, 55990.16014759782, 56259.71870140705, 7945.761627151194, 7970.8007299815645, 7977.840443190988, 7999.720009799629, 8190.1400352964465, 38887.41668874912, 39327.41008884812, 40491.19017619572, 40498.0, 41432.1713565721, 49393.50606493889, 53296.73351633217, 53504.0, 54631.0, 55331.44668553424, 7774.572398517909, 7787.727429539939, 8000.359971202406, 8080.4343695940715, 8145.470544414594, 10912.890871091187, 11038.613648522263, 11157.27477713946, 11360.1479889007, 11469.0, 9786.41281523111, 9887.456189909624, 9949.850752238577, 10032.69901902944, 10221.182305415401, 10921.508532116233, 11023.61417350389, 11058.447077645924, 11202.21584489078, 11472.827907581226, 9924.553395097093, 9986.35088719231, 10046.899531004596, 10047.447390393307, 10129.544170512198, 9207.76980575491, 9511.66709165176, 9933.0, 9955.253355998473, 9992.850107248543, 8421.284190843848, 8441.268866008017, 8503.617337219715, 8568.100349463217, 8736.25741811953], "unit": "ms", "name": "yui.html", "value": 6312.675810699327}], "name": "dromaeo_css", "value": 7100.3565003992335}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 109.0, 105.0, 110.0, 109.0, 109.0, 102.0, 111.0, 106.0, 110.0], "unit": "ms", "name": "ai-astar", "value": 108.1}, {"lowerIsBetter": true, "replicates": [150.0, 128.0, 149.0, 167.0, 123.0, 152.0, 150.0, 122.0, 159.0, 122.0], "unit": "ms", "name": "audio-beat-detection", "value": 142.2}, {"lowerIsBetter": true, "replicates": [159.0, 161.0, 160.0, 160.0, 160.0, 160.0, 162.0, 163.0, 161.0, 160.0], "unit": "ms", "name": "audio-dft", "value": 160.6}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 72.0, 138.0, 71.0, 71.0, 77.0, 72.0, 163.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 87.8}, {"lowerIsBetter": true, "replicates": [90.0, 89.0, 132.0, 90.0, 90.0, 90.0, 143.0, 89.0, 90.0, 134.0], "unit": "ms", "name": "audio-oscillator", "value": 103.7}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 111.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 145.0, 146.0, 145.0, 147.0, 145.0, 145.0, 146.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.4}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [54.0, 56.0, 55.0, 55.0, 64.0, 54.0, 56.0, 55.0, 53.0, 53.0], "unit": "ms", "name": "json-parse-financial", "value": 55.5}, {"lowerIsBetter": true, "replicates": [62.0, 64.0, 63.0, 63.0, 63.0, 63.0, 63.0, 63.0, 64.0, 63.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 63.1}, {"lowerIsBetter": true, "replicates": [77.0, 79.0, 78.0, 78.0, 93.0, 78.0, 77.0, 78.0, 78.0, 78.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 79.4}, {"lowerIsBetter": true, "replicates": [111.0, 116.0, 115.0, 113.0, 124.0, 110.0, 114.0, 111.0, 110.0, 110.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 113.4}, {"lowerIsBetter": true, "replicates": [136.0, 139.0, 135.0, 139.0, 126.0, 128.0, 125.0, 141.0, 135.0, 136.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 134.0}, {"lowerIsBetter": true, "replicates": [60.0, 62.0, 62.0, 62.0, 64.0, 61.0, 61.0, 62.0, 61.0, 61.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 61.6}], "name": "kraken", "value": 1459.6}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.61112962345885], "unit": "score", "name": "Richards", "value": 211.88260400000004}, {"lowerIsBetter": false, "replicates": [170.32873445750297], "unit": "score", "name": "DeltaBlue", "value": 388.1787779999999}, {"lowerIsBetter": false, "replicates": [280.42624789680315], "unit": "score", "name": "Encrypt", "value": 949.2014460000001}, {"lowerIsBetter": false, "replicates": [5010.0], "unit": "score", "name": "Decrypt", "value": 53.12994011976049}, {"lowerIsBetter": false, "replicates": [934.5794392523364], "unit": "score", "name": "RayTrace", "value": 791.7882300000002}, {"lowerIsBetter": false, "replicates": [557.7244841048522], "unit": "score", "name": "Earley", "value": 1194.968159}, {"lowerIsBetter": false, "replicates": [10479.166666666666], "unit": "score", "name": "Boyer", "value": 63.59885487077532}, {"lowerIsBetter": false, "replicates": [23418.60465116279], "unit": "score", "name": "RegExp", "value": 38.90005461767626}, {"lowerIsBetter": false, "replicates": [544.3658138268917], "unit": "score", "name": "Splay", "value": 149.69896699999998}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 23256.679478186674}]} 14:45:09 INFO - RETURN: dromaeo_css: 7100.36 14:45:09 INFO - RETURN: kraken: 1459.60 14:45:09 INFO - RETURN: v8_7: 23256.68 14:45:09 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,53,35]]", "result": "23256.68"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,53,35]]", "result": "1459.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,53,35]]", "result": "7100.36"}}} 14:45:09 INFO - Return code: 0 14:45:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 14:45:09 INFO - # TBPL SUCCESS # 14:45:09 INFO - Running post-action listener: _resource_record_post_action 14:45:09 INFO - Running post-run listener: _resource_record_post_run 14:45:10 INFO - Total resource usage - Wall time: 1220s; CPU: 13.0%; Read bytes: 315392; Write bytes: 511520768; Read time: 52; Write time: 600888 14:45:10 INFO - install - Wall time: 14s; CPU: 16.0%; Read bytes: 0; Write bytes: 250482688; Read time: 0; Write time: 426992 14:45:10 INFO - run-tests - Wall time: 1206s; CPU: 13.0%; Read bytes: 315392; Write bytes: 260698112; Read time: 52; Write time: 173860 14:45:10 INFO - Running post-run listener: _upload_blobber_files 14:45:10 INFO - Blob upload gear active. 14:45:10 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 14:45:10 INFO - Copying logs to upload dir... 14:45:10 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1256.817562 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-01-18 14:45:10.387273) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-18 14:45:10.391106) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1453155511.984397-1926919890 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453147231/firefox-44.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009954 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453147231/firefox-44.0.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.05 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-18 14:45:10.446668) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 14:45:10.447035) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1453155511.984397-1926919890 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004553 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 14:45:10.496768) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-18 14:45:10.497135) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-18 14:45:10.497484) ========= ========= Total master_lag: 0.30 =========