builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-012 starttime: 1453722744.61 results: success (0) buildid: 20160118120031 builduid: 818fd5d38f994d05b8cc299dc07eda1c revision: f84fcce02b11 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-25 03:52:24.611608) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-25 03:52:24.612047) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-25 03:52:24.612329) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1453722744.672701-1797511328 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.004346 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-25 03:52:24.629640) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-25 03:52:24.629934) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-25 03:52:24.640226) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 03:52:24.640531) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1453722744.672701-1797511328 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004624 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 03:52:24.689509) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-25 03:52:24.689823) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-25 03:52:24.690166) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 03:52:24.690432) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1453722744.672701-1797511328 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-25 03:52:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2016-01-25 03:52:25 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.198274 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 03:52:24.900928) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 03:52:24.901248) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1453722744.672701-1797511328 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.012422 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 03:52:24.973428) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 03:52:24.973785) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1453722744.672701-1797511328 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-25 03:52:25,703 Setting DEBUG logging. 2016-01-25 03:52:25,703 attempt 1/10 2016-01-25 03:52:25,703 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-25 03:52:26,096 unpacking tar archive at: mozilla-beta-f84fcce02b11/testing/mozharness/ program finished with exit code 0 elapsedTime=0.723693 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 03:52:25.710205) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-25 03:52:25.710563) ========= echo f84fcce02b11 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'f84fcce02b11'] 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=2c5dd2b0a310ecf02fd87158000001b4-1453722744.672701-1797511328 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False f84fcce02b11 program finished with exit code 0 elapsedTime=0.004684 script_repo_revision: 'f84fcce02b11' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-25 03:52:25.761428) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-25 03:52:25.761747) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-25 03:52:25.772155) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-01-25 03:52:25.772529) ========= /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=2c5dd2b0a310ecf02fd87158000001b4-1453722744.672701-1797511328 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:52:26 INFO - MultiFileLogger online at 20160125 03:52:26 in /builds/slave/test-pgo 03:52:26 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 03:52:26 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 03:52:26 INFO - {'append_to_log': False, 03:52:26 INFO - 'base_work_dir': '/builds/slave/test-pgo', 03:52:26 INFO - 'blob_upload_branch': 'Mozilla-Beta', 03:52:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 03:52:26 INFO - 'branch': 'Mozilla-Beta', 03:52:26 INFO - 'buildbot_json_path': 'buildprops.json', 03:52:26 INFO - 'config_files': ('talos/linux_config.py',), 03:52:26 INFO - 'default_actions': ('clobber', 03:52:26 INFO - 'read-buildbot-config', 03:52:26 INFO - 'download-and-extract', 03:52:26 INFO - 'populate-webroot', 03:52:26 INFO - 'create-virtualenv', 03:52:26 INFO - 'install', 03:52:26 INFO - 'run-tests'), 03:52:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:52:26 INFO - 'download_minidump_stackwalk': True, 03:52:26 INFO - 'download_symbols': 'ondemand', 03:52:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:52:26 INFO - 'tooltool.py': '/tools/tooltool.py', 03:52:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:52:26 INFO - '/tools/misc-python/virtualenv.py')}, 03:52:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:52:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:52:26 INFO - 'installer_path': 'installer.exe', 03:52:26 INFO - 'log_level': 'info', 03:52:26 INFO - 'log_name': 'talos', 03:52:26 INFO - 'log_to_console': True, 03:52:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:52:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:52:26 INFO - 'opt_config_files': (), 03:52:26 INFO - 'pip_index': False, 03:52:26 INFO - 'sps_profile': False, 03:52:26 INFO - 'sps_profile_interval': 0, 03:52:26 INFO - 'suite': 'dromaeojs', 03:52:26 INFO - 'system_bits': '32', 03:52:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:52:26 INFO - 'title': 'talos-linux64-ix-012', 03:52:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:52:26 INFO - 'use_talos_json': True, 03:52:26 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 03:52:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:52:26 INFO - 'work_dir': 'build'} 03:52:26 INFO - ##### 03:52:26 INFO - ##### Running clobber step. 03:52:26 INFO - ##### 03:52:26 INFO - Running pre-action listener: _resource_record_pre_action 03:52:26 INFO - Running main action method: clobber 03:52:26 INFO - rmtree: /builds/slave/test-pgo/build 03:52:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 03:52:27 INFO - Running post-action listener: _resource_record_post_action 03:52:27 INFO - ##### 03:52:27 INFO - ##### Running read-buildbot-config step. 03:52:27 INFO - ##### 03:52:27 INFO - Running pre-action listener: _resource_record_pre_action 03:52:27 INFO - Running main action method: read_buildbot_config 03:52:27 INFO - Using buildbot properties: 03:52:27 INFO - { 03:52:27 INFO - "properties": { 03:52:27 INFO - "buildnumber": 91, 03:52:27 INFO - "product": "firefox", 03:52:27 INFO - "script_repo_revision": "production", 03:52:27 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 03:52:27 INFO - "repository": "", 03:52:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 03:52:27 INFO - "buildid": "20160118120031", 03:52:27 INFO - "slavename": "talos-linux64-ix-012", 03:52:27 INFO - "pgo_build": "True", 03:52:27 INFO - "basedir": "/builds/slave/test-pgo", 03:52:27 INFO - "project": "", 03:52:27 INFO - "platform": "ubuntu64_hw", 03:52:27 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:52:27 INFO - "slavebuilddir": "test", 03:52:27 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 03:52:27 INFO - "branch": "mozilla-beta", 03:52:27 INFO - "repo_path": "releases/mozilla-beta", 03:52:27 INFO - "stage_platform": "linux64-pgo", 03:52:27 INFO - "builduid": "818fd5d38f994d05b8cc299dc07eda1c", 03:52:27 INFO - "revision": "f84fcce02b11" 03:52:27 INFO - }, 03:52:27 INFO - "sourcestamp": { 03:52:27 INFO - "repository": "", 03:52:27 INFO - "hasPatch": false, 03:52:27 INFO - "project": "", 03:52:27 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 03:52:27 INFO - "changes": [ 03:52:27 INFO - { 03:52:27 INFO - "category": null, 03:52:27 INFO - "files": [ 03:52:27 INFO - { 03:52:27 INFO - "url": null, 03:52:27 INFO - "name": "http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453147231/firefox-44.0.en-US.linux-x86_64.tar.bz2" 03:52:27 INFO - } 03:52:27 INFO - ], 03:52:27 INFO - "repository": "", 03:52:27 INFO - "rev": "f84fcce02b11", 03:52:27 INFO - "who": "sendchange", 03:52:27 INFO - "when": 1453155801, 03:52:27 INFO - "number": 7475630, 03:52:27 INFO - "comments": "Bug 1233982 - Do not fetch autofill icons from the network. r=adw a=ritu CLOSED TREE", 03:52:27 INFO - "project": "", 03:52:27 INFO - "at": "Mon 18 Jan 2016 14:23:21", 03:52:27 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 03:52:27 INFO - "revlink": "", 03:52:27 INFO - "properties": [ 03:52:27 INFO - [ 03:52:27 INFO - "buildid", 03:52:27 INFO - "20160118120031", 03:52:27 INFO - "Change" 03:52:27 INFO - ], 03:52:27 INFO - [ 03:52:27 INFO - "builduid", 03:52:27 INFO - "818fd5d38f994d05b8cc299dc07eda1c", 03:52:27 INFO - "Change" 03:52:27 INFO - ], 03:52:27 INFO - [ 03:52:27 INFO - "pgo_build", 03:52:27 INFO - "True", 03:52:27 INFO - "Change" 03:52:27 INFO - ] 03:52:27 INFO - ], 03:52:27 INFO - "revision": "f84fcce02b11" 03:52:27 INFO - } 03:52:27 INFO - ], 03:52:27 INFO - "revision": "f84fcce02b11" 03:52:27 INFO - } 03:52:27 INFO - } 03:52:27 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. 03:52:27 INFO - Running post-action listener: _resource_record_post_action 03:52:27 INFO - ##### 03:52:27 INFO - ##### Running download-and-extract step. 03:52:27 INFO - ##### 03:52:27 INFO - Running pre-action listener: _resource_record_pre_action 03:52:27 INFO - Running main action method: download_and_extract 03:52:27 INFO - mkdir: /builds/slave/test-pgo/build/tests 03:52:27 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')]} 03:52:27 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453147231/test_packages.json 03:52:27 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 03:52:27 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 03:52:27 INFO - Downloaded 1270 bytes. 03:52:27 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 03:52:27 INFO - Using the following test package requirements: 03:52:27 INFO - {u'common': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip'], 03:52:27 INFO - u'cppunittest': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 03:52:27 INFO - u'firefox-44.0.en-US.linux-x86_64.cppunittest.tests.zip'], 03:52:27 INFO - u'jittest': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 03:52:27 INFO - u'jsshell-linux-x86_64.zip'], 03:52:27 INFO - u'mochitest': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 03:52:27 INFO - u'firefox-44.0.en-US.linux-x86_64.mochitest.tests.zip'], 03:52:27 INFO - u'mozbase': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip'], 03:52:27 INFO - u'reftest': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 03:52:27 INFO - u'firefox-44.0.en-US.linux-x86_64.reftest.tests.zip'], 03:52:27 INFO - u'talos': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 03:52:27 INFO - u'firefox-44.0.en-US.linux-x86_64.talos.tests.zip'], 03:52:27 INFO - u'web-platform': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 03:52:27 INFO - u'firefox-44.0.en-US.linux-x86_64.web-platform.tests.zip'], 03:52:27 INFO - u'webapprt': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip'], 03:52:27 INFO - u'xpcshell': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 03:52:27 INFO - u'firefox-44.0.en-US.linux-x86_64.xpcshell.tests.zip']} 03:52:27 INFO - Downloading packages: [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:52:27 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')]} 03:52:27 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 03:52:27 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 03:52:27 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 03:52:27 INFO - Downloaded 22573307 bytes. 03:52:27 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 03:52:27 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip 03:52:27 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 03:52:28 INFO - Return code: 0 03:52:28 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 03:52: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')]} 03:52:28 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 03:52:28 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 03:52:28 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 03:52:29 INFO - Downloaded 22573307 bytes. 03:52:29 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 03:52:29 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip 03:52:29 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 03:52:30 INFO - Return code: 0 03:52:30 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')]} 03:52:30 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 03:52:30 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 03:52:30 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 03:52:31 INFO - Downloaded 11131970 bytes. 03:52:31 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 03:52:31 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.talos.tests.zip 03:52:31 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 03:52:31 INFO - Return code: 0 03:52: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')]} 03:52:31 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453147231/firefox-44.0.en-US.linux-x86_64.tar.bz2 03:52:31 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 03:52:31 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 03:52:32 INFO - Downloaded 56626174 bytes. 03:52:32 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 03:52:32 INFO - mkdir: /builds/slave/test-pgo/properties 03:52:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 03:52:32 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 03:52:32 INFO - Contents: 03:52:32 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 03:52:32 INFO - Running post-action listener: _resource_record_post_action 03:52:32 INFO - Running post-action listener: set_extra_try_arguments 03:52:32 INFO - ##### 03:52:32 INFO - ##### Running populate-webroot step. 03:52:32 INFO - ##### 03:52:32 INFO - Running pre-action listener: _resource_record_pre_action 03:52:32 INFO - Running main action method: populate_webroot 03:52:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:52:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:52:32 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 03:52:32 INFO - '../fennec_ids.txt'], 03:52:32 INFO - 'tests': ['tcheck2']}, 03:52:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:52:32 INFO - '--tppagecycles', 03:52:32 INFO - '7'], 03:52:32 INFO - 'tests': ['tsvgm']}}, 03:52:32 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:52:32 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:52:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:52:32 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:52:32 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:52:32 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:52:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:52:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:52:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:52:32 INFO - 'talos_options': ['--e10s'], 03:52:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:52:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:52:32 INFO - 'tests': ['damp', 'tps']}, 03:52:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:52:32 INFO - 'talos_options': ['--e10s'], 03:52:32 INFO - 'tests': ['damp', 'tps']}, 03:52:32 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:52:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:52:32 INFO - 'other': {'tests': ['a11yr', 03:52:32 INFO - 'ts_paint', 03:52:32 INFO - 'tpaint', 03:52:32 INFO - 'sessionrestore', 03:52:32 INFO - 'sessionrestore_no_auto_restore']}, 03:52:32 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:52:32 INFO - 'tests': ['a11yr', 03:52:32 INFO - 'ts_paint', 03:52:32 INFO - 'tpaint', 03:52:32 INFO - 'sessionrestore', 03:52:32 INFO - 'sessionrestore_no_auto_restore']}, 03:52:32 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:52:32 INFO - 'tests': ['a11yr', 03:52:32 INFO - 'ts_paint', 03:52:32 INFO - 'tpaint', 03:52:32 INFO - 'sessionrestore', 03:52:32 INFO - 'sessionrestore_no_auto_restore']}, 03:52:32 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:52:32 INFO - 'tests': ['a11yr', 03:52:32 INFO - 'ts_paint', 03:52:32 INFO - 'tpaint', 03:52:32 INFO - 'sessionrestore', 03:52:32 INFO - 'sessionrestore_no_auto_restore']}, 03:52:32 INFO - 'other_l64': {'tests': ['a11yr', 03:52:32 INFO - 'ts_paint', 03:52:32 INFO - 'tpaint', 03:52:32 INFO - 'sessionrestore', 03:52:32 INFO - 'sessionrestore_no_auto_restore']}, 03:52:32 INFO - 'other_nol64': {'tests': ['a11yr', 03:52:32 INFO - 'ts_paint', 03:52:32 INFO - 'tpaint', 03:52:32 INFO - 'sessionrestore', 03:52:32 INFO - 'sessionrestore_no_auto_restore']}, 03:52:32 INFO - 'svgr': {'tests': ['tsvgx', 03:52:32 INFO - 'tsvgr_opacity', 03:52:32 INFO - 'tart', 03:52:32 INFO - 'tscrollx', 03:52:32 INFO - 'cart']}, 03:52:32 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:52:32 INFO - 'tests': ['tsvgx', 03:52:32 INFO - 'tsvgr_opacity', 03:52:32 INFO - 'tart', 03:52:32 INFO - 'tscrollx', 03:52:32 INFO - 'cart']}, 03:52:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:52:32 INFO - 'tests': ['tp5o']}, 03:52:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:52:32 INFO - 'talos_options': ['--e10s'], 03:52:32 INFO - 'tests': ['tp5o']}, 03:52:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:52:32 INFO - 'talos_options': ['--xperf_path', 03:52:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:52:32 INFO - 'tests': ['tp5n']}, 03:52:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:52:32 INFO - 'talos_options': ['--e10s', 03:52:32 INFO - '--xperf_path', 03:52:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:52:32 INFO - 'tests': ['tp5n']}}, 03:52:32 INFO - 'talos.zip': {'path': '', 03:52:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:52:32 INFO - Running post-action listener: _resource_record_post_action 03:52:32 INFO - ##### 03:52:32 INFO - ##### Running create-virtualenv step. 03:52:32 INFO - ##### 03:52:32 INFO - Running pre-action listener: _resource_record_pre_action 03:52:32 INFO - Running main action method: create_virtualenv 03:52:32 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 03:52:32 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 03:52:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 03:52:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:52:32 INFO - Using real prefix '/usr' 03:52:32 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 03:52:33 INFO - Installing distribute.............................................................................................................................................................................................done. 03:52:35 INFO - Installing pip.................done. 03:52:35 INFO - Return code: 0 03:52:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 03:52:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:52:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:52:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:35 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 0x7f710e718f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2156600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e5350>, '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 0x21e6250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21e66e0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1453722744.672701-1797511328', '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 03:52:35 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 03:52:35 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 03:52:35 INFO - Using env: {'DISPLAY': ':0', 03:52:35 INFO - 'HOME': '/home/cltbld', 03:52:35 INFO - 'LANG': 'en_US.UTF-8', 03:52:35 INFO - 'LANGUAGE': 'en_US:en', 03:52:35 INFO - 'LOGNAME': 'cltbld', 03:52:35 INFO - 'MAIL': '/var/mail/cltbld', 03:52:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:35 INFO - 'MOZ_NO_REMOTE': '1', 03:52:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:35 INFO - 'NO_EM_RESTART': '1', 03:52:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:52:35 INFO - 'PWD': '/builds/slave/test-pgo', 03:52:35 INFO - 'SHELL': '/bin/bash', 03:52:35 INFO - 'SHLVL': '1', 03:52:35 INFO - 'TERM': 'linux', 03:52:35 INFO - 'TMOUT': '86400', 03:52:35 INFO - 'USER': 'cltbld', 03:52:35 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1453722744.672701-1797511328', 03:52:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:35 INFO - '_': '/tools/buildbot/bin/python'} 03:52:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:35 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 03:52:35 INFO - Cleaning up... 03:52:35 INFO - Return code: 0 03:52:35 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 03:52:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:52:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:52:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:35 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 0x7f710e718f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2156600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e5350>, '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 0x21e6250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21e66e0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1453722744.672701-1797511328', '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 03:52:35 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 03:52:35 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 03:52:35 INFO - Using env: {'DISPLAY': ':0', 03:52:35 INFO - 'HOME': '/home/cltbld', 03:52:35 INFO - 'LANG': 'en_US.UTF-8', 03:52:35 INFO - 'LANGUAGE': 'en_US:en', 03:52:35 INFO - 'LOGNAME': 'cltbld', 03:52:35 INFO - 'MAIL': '/var/mail/cltbld', 03:52:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:35 INFO - 'MOZ_NO_REMOTE': '1', 03:52:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:35 INFO - 'NO_EM_RESTART': '1', 03:52:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:52:35 INFO - 'PWD': '/builds/slave/test-pgo', 03:52:35 INFO - 'SHELL': '/bin/bash', 03:52:35 INFO - 'SHLVL': '1', 03:52:35 INFO - 'TERM': 'linux', 03:52:35 INFO - 'TMOUT': '86400', 03:52:35 INFO - 'USER': 'cltbld', 03:52:35 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1453722744.672701-1797511328', 03:52:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:35 INFO - '_': '/tools/buildbot/bin/python'} 03:52:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:35 INFO - Downloading/unpacking psutil>=0.7.1 03:52: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 03:52: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 03:52: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 03:52: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 03:52: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 03:52: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 03:52:37 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 03:52:37 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 03:52:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 03:52:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:52:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:52:37 INFO - Installing collected packages: psutil 03:52:37 INFO - Running setup.py install for psutil 03:52:37 INFO - building 'psutil._psutil_linux' extension 03:52:37 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 03:52:37 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 03:52:37 INFO - building 'psutil._psutil_posix' extension 03:52:37 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 03:52:37 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 03:52:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:52:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:52:37 INFO - Successfully installed psutil 03:52:37 INFO - Cleaning up... 03:52:38 INFO - Return code: 0 03:52:38 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 03:52:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:52:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:52:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:38 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 0x7f710e718f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2156600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e5350>, '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 0x21e6250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21e66e0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1453722744.672701-1797511328', '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 03:52:38 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 03:52:38 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 03:52:38 INFO - Using env: {'DISPLAY': ':0', 03:52:38 INFO - 'HOME': '/home/cltbld', 03:52:38 INFO - 'LANG': 'en_US.UTF-8', 03:52:38 INFO - 'LANGUAGE': 'en_US:en', 03:52:38 INFO - 'LOGNAME': 'cltbld', 03:52:38 INFO - 'MAIL': '/var/mail/cltbld', 03:52:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:38 INFO - 'MOZ_NO_REMOTE': '1', 03:52:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:38 INFO - 'NO_EM_RESTART': '1', 03:52:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:52:38 INFO - 'PWD': '/builds/slave/test-pgo', 03:52:38 INFO - 'SHELL': '/bin/bash', 03:52:38 INFO - 'SHLVL': '1', 03:52:38 INFO - 'TERM': 'linux', 03:52:38 INFO - 'TMOUT': '86400', 03:52:38 INFO - 'USER': 'cltbld', 03:52:38 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1453722744.672701-1797511328', 03:52:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:38 INFO - '_': '/tools/buildbot/bin/python'} 03:52:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:38 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:52:38 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 03:52:38 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 03:52:38 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 03:52:38 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 03:52:38 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 03:52:38 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 03:52:40 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:52:40 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 03:52:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:52:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:52:40 INFO - Installing collected packages: mozsystemmonitor 03:52:40 INFO - Running setup.py install for mozsystemmonitor 03:52:40 INFO - Successfully installed mozsystemmonitor 03:52:40 INFO - Cleaning up... 03:52:40 INFO - Return code: 0 03:52:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 03:52:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:52:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:52:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:40 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f710e718f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2156600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e5350>, '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 0x21e6250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21e66e0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1453722744.672701-1797511328', '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 03:52:40 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 03:52:40 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 03:52:40 INFO - Using env: {'DISPLAY': ':0', 03:52:40 INFO - 'HOME': '/home/cltbld', 03:52:40 INFO - 'LANG': 'en_US.UTF-8', 03:52:40 INFO - 'LANGUAGE': 'en_US:en', 03:52:40 INFO - 'LOGNAME': 'cltbld', 03:52:40 INFO - 'MAIL': '/var/mail/cltbld', 03:52:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:40 INFO - 'MOZ_NO_REMOTE': '1', 03:52:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:40 INFO - 'NO_EM_RESTART': '1', 03:52:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:52:40 INFO - 'PWD': '/builds/slave/test-pgo', 03:52:40 INFO - 'SHELL': '/bin/bash', 03:52:40 INFO - 'SHLVL': '1', 03:52:40 INFO - 'TERM': 'linux', 03:52:40 INFO - 'TMOUT': '86400', 03:52:40 INFO - 'USER': 'cltbld', 03:52:40 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1453722744.672701-1797511328', 03:52:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:40 INFO - '_': '/tools/buildbot/bin/python'} 03:52:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:40 INFO - Downloading/unpacking blobuploader==1.2.4 03:52:40 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 03:52:40 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 03:52:40 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 03:52:40 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 03:52:40 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 03:52:40 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 03:52:42 INFO - Downloading blobuploader-1.2.4.tar.gz 03:52:42 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 03:52:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:52:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:52:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:52:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:52:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:42 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 03:52:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 03:52:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:52:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:52:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:52:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:42 INFO - Downloading docopt-0.6.1.tar.gz 03:52:42 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 03:52:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 03:52:42 INFO - Installing collected packages: blobuploader, requests, docopt 03:52:42 INFO - Running setup.py install for blobuploader 03:52:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:52:43 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 03:52:43 INFO - Running setup.py install for requests 03:52:43 INFO - Running setup.py install for docopt 03:52:43 INFO - Successfully installed blobuploader requests docopt 03:52:43 INFO - Cleaning up... 03:52:43 INFO - Return code: 0 03:52:43 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:52: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')]} 03:52:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52: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')]} 03:52:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:43 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 0x7f710e718f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2156600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e5350>, '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 0x21e6250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21e66e0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1453722744.672701-1797511328', '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 03:52:43 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 03:52:43 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 03:52:43 INFO - Using env: {'DISPLAY': ':0', 03:52:43 INFO - 'HOME': '/home/cltbld', 03:52:43 INFO - 'LANG': 'en_US.UTF-8', 03:52:43 INFO - 'LANGUAGE': 'en_US:en', 03:52:43 INFO - 'LOGNAME': 'cltbld', 03:52:43 INFO - 'MAIL': '/var/mail/cltbld', 03:52:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:43 INFO - 'MOZ_NO_REMOTE': '1', 03:52:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:43 INFO - 'NO_EM_RESTART': '1', 03:52:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:52:43 INFO - 'PWD': '/builds/slave/test-pgo', 03:52:43 INFO - 'SHELL': '/bin/bash', 03:52:43 INFO - 'SHLVL': '1', 03:52:43 INFO - 'TERM': 'linux', 03:52:43 INFO - 'TMOUT': '86400', 03:52:43 INFO - 'USER': 'cltbld', 03:52:43 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1453722744.672701-1797511328', 03:52:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:43 INFO - '_': '/tools/buildbot/bin/python'} 03:52:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:52:43 INFO - Running setup.py (path:/tmp/pip-OqWg8V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:52:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:52:43 INFO - Running setup.py (path:/tmp/pip-LmzNox-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:52:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:52:43 INFO - Running setup.py (path:/tmp/pip-xhkc13-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:52:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:52:43 INFO - Running setup.py (path:/tmp/pip-6wknGh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:52:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:52:44 INFO - Running setup.py (path:/tmp/pip-ER08_e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:52:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:52:44 INFO - Running setup.py (path:/tmp/pip-BW3L79-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:52:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:52:44 INFO - Running setup.py (path:/tmp/pip-oHPC6o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:52:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:52:44 INFO - Running setup.py (path:/tmp/pip-25tM9V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:52:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:52:44 INFO - Running setup.py (path:/tmp/pip-m1I3cq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:52:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:52:44 INFO - Running setup.py (path:/tmp/pip-5mrRcy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:52:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:52:44 INFO - Running setup.py (path:/tmp/pip-h6aftD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:52:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:52:44 INFO - Running setup.py (path:/tmp/pip-onHdJt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:52:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:52:44 INFO - Running setup.py (path:/tmp/pip-cvZ2OK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:52:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:52:44 INFO - Running setup.py (path:/tmp/pip-1ZH4YF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:52:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:52:44 INFO - Running setup.py (path:/tmp/pip-L_cCym-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:52:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:52:44 INFO - Running setup.py (path:/tmp/pip-omxoZ0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:52:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:52:44 INFO - Running setup.py (path:/tmp/pip-WbmpGk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:52:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:52:44 INFO - Running setup.py install for manifestparser 03:52:45 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 03:52:45 INFO - Running setup.py install for mozcrash 03:52:45 INFO - Running setup.py install for mozdebug 03:52:45 INFO - Running setup.py install for mozdevice 03:52:45 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 03:52:45 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 03:52:45 INFO - Running setup.py install for mozfile 03:52:45 INFO - Running setup.py install for mozhttpd 03:52:45 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 03:52:45 INFO - Running setup.py install for mozinfo 03:52:45 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 03:52:45 INFO - Running setup.py install for mozInstall 03:52:45 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 03:52:45 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 03:52:45 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 03:52:45 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 03:52:45 INFO - Running setup.py install for mozleak 03:52:45 INFO - Running setup.py install for mozlog 03:52:45 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 03:52:46 INFO - Running setup.py install for moznetwork 03:52:46 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 03:52:46 INFO - Running setup.py install for mozprocess 03:52:46 INFO - Running setup.py install for mozprofile 03:52:46 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 03:52:46 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 03:52:46 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 03:52:46 INFO - Running setup.py install for mozrunner 03:52:46 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 03:52:46 INFO - Running setup.py install for mozscreenshot 03:52:46 INFO - Running setup.py install for moztest 03:52:46 INFO - Running setup.py install for mozversion 03:52:46 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 03:52:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:52:46 INFO - Cleaning up... 03:52:46 INFO - Return code: 0 03:52:46 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:52: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')]} 03:52:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52: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')]} 03:52:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52: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', '-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 0x7f710e718f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2156600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e5350>, '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 0x21e6250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21e66e0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1453722744.672701-1797511328', '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 03:52:46 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 03:52:46 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 03:52:46 INFO - Using env: {'DISPLAY': ':0', 03:52:46 INFO - 'HOME': '/home/cltbld', 03:52:46 INFO - 'LANG': 'en_US.UTF-8', 03:52:46 INFO - 'LANGUAGE': 'en_US:en', 03:52:46 INFO - 'LOGNAME': 'cltbld', 03:52:46 INFO - 'MAIL': '/var/mail/cltbld', 03:52:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:46 INFO - 'MOZ_NO_REMOTE': '1', 03:52:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:46 INFO - 'NO_EM_RESTART': '1', 03:52:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:52:46 INFO - 'PWD': '/builds/slave/test-pgo', 03:52:46 INFO - 'SHELL': '/bin/bash', 03:52:46 INFO - 'SHLVL': '1', 03:52:46 INFO - 'TERM': 'linux', 03:52:46 INFO - 'TMOUT': '86400', 03:52:46 INFO - 'USER': 'cltbld', 03:52:46 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1453722744.672701-1797511328', 03:52:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:46 INFO - '_': '/tools/buildbot/bin/python'} 03:52:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:52:46 INFO - Running setup.py (path:/tmp/pip-MbLlIo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:52:47 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)) 03:52:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:52:47 INFO - Running setup.py (path:/tmp/pip-xbxari-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:52:47 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)) 03:52:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:52:47 INFO - Running setup.py (path:/tmp/pip-rFf8W1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:52:47 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)) 03:52:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:52:47 INFO - Running setup.py (path:/tmp/pip-kLzpyI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:52:47 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)) 03:52:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:52:47 INFO - Running setup.py (path:/tmp/pip-Jk1OJV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:52:47 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)) 03:52:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:52:47 INFO - Running setup.py (path:/tmp/pip-mxBVsn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:52:47 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)) 03:52:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:52:47 INFO - Running setup.py (path:/tmp/pip-oLOLny-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:52:47 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)) 03:52:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:52:47 INFO - Running setup.py (path:/tmp/pip-qr31yQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:52:47 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)) 03:52:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:52:47 INFO - Running setup.py (path:/tmp/pip-kRR2Oh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:52:47 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)) 03:52:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:52:47 INFO - Running setup.py (path:/tmp/pip-t8hDfF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:52:47 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)) 03:52:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:52:47 INFO - Running setup.py (path:/tmp/pip-m_IPZH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:52:47 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)) 03:52:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:52:47 INFO - Running setup.py (path:/tmp/pip-Qs8iyO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:52:47 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)) 03:52:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:52:47 INFO - Running setup.py (path:/tmp/pip-wYUD0Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:52:47 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)) 03:52:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:52:47 INFO - Running setup.py (path:/tmp/pip-ggUqHZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:52:47 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)) 03:52:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:52:47 INFO - Running setup.py (path:/tmp/pip-HNn_uR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:52:48 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)) 03:52:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:52:48 INFO - Running setup.py (path:/tmp/pip-u5IcMh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:52:48 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)) 03:52:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:52:48 INFO - Running setup.py (path:/tmp/pip-uqHZhs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:52:48 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)) 03:52:48 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)) 03:52:48 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)) 03:52:48 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)) 03:52:48 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)) 03:52:48 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)) 03:52:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 03:52: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 03:52: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 03:52: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 03:52: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 03:52: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 03:52: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 03:52:49 INFO - Downloading blessings-1.6.tar.gz 03:52:49 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.6.tar.gz 03:52:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 03:52:50 INFO - Installing collected packages: blessings 03:52:50 INFO - Running setup.py install for blessings 03:52:50 INFO - Successfully installed blessings 03:52:50 INFO - Cleaning up... 03:52:50 INFO - Return code: 0 03:52:50 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 03:52:50 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:52:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:52:50 INFO - Reading from file tmpfile_stdout 03:52:50 INFO - Current package versions: 03:52:50 INFO - argparse == 1.2.1 03:52:50 INFO - blessings == 1.6 03:52:50 INFO - blobuploader == 1.2.4 03:52:50 INFO - docopt == 0.6.1 03:52:50 INFO - manifestparser == 1.1 03:52:50 INFO - mozInstall == 1.12 03:52:50 INFO - mozcrash == 0.16 03:52:50 INFO - mozdebug == 0.1 03:52:50 INFO - mozdevice == 0.46 03:52:50 INFO - mozfile == 1.2 03:52:50 INFO - mozhttpd == 0.7 03:52:50 INFO - mozinfo == 0.8 03:52:50 INFO - mozleak == 0.1 03:52:50 INFO - mozlog == 3.0 03:52:50 INFO - moznetwork == 0.27 03:52:50 INFO - mozprocess == 0.22 03:52:50 INFO - mozprofile == 0.27 03:52:50 INFO - mozrunner == 6.11 03:52:50 INFO - mozscreenshot == 0.1 03:52:50 INFO - mozsystemmonitor == 0.0 03:52:50 INFO - moztest == 0.7 03:52:50 INFO - mozversion == 1.4 03:52:50 INFO - psutil == 3.1.1 03:52:50 INFO - requests == 1.2.3 03:52:50 INFO - wsgiref == 0.1.2 03:52:50 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:52:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:52:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:52:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:50 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f710e718f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2156600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e5350>, '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 0x21e6250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21e66e0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1453722744.672701-1797511328', '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 03:52:50 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 03:52:50 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 03:52:50 INFO - Using env: {'DISPLAY': ':0', 03:52:50 INFO - 'HOME': '/home/cltbld', 03:52:50 INFO - 'LANG': 'en_US.UTF-8', 03:52:50 INFO - 'LANGUAGE': 'en_US:en', 03:52:50 INFO - 'LOGNAME': 'cltbld', 03:52:50 INFO - 'MAIL': '/var/mail/cltbld', 03:52:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:50 INFO - 'MOZ_NO_REMOTE': '1', 03:52:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:50 INFO - 'NO_EM_RESTART': '1', 03:52:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:52:50 INFO - 'PWD': '/builds/slave/test-pgo', 03:52:50 INFO - 'SHELL': '/bin/bash', 03:52:50 INFO - 'SHLVL': '1', 03:52:50 INFO - 'TERM': 'linux', 03:52:50 INFO - 'TMOUT': '86400', 03:52:50 INFO - 'USER': 'cltbld', 03:52:50 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1453722744.672701-1797511328', 03:52:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:50 INFO - '_': '/tools/buildbot/bin/python'} 03:52:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:50 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)) 03:52:50 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)) 03:52:50 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)) 03:52:50 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)) 03:52:50 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)) 03:52:50 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)) 03:52:50 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)) 03:52:50 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)) 03:52:50 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)) 03:52:50 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)) 03:52:50 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)) 03:52:50 INFO - Cleaning up... 03:52:50 INFO - Return code: 0 03:52:50 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 03:52:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:52:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:52:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:50 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f710e718f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2156600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e5350>, '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 0x21e6250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21e66e0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1453722744.672701-1797511328', '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 03:52:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 03:52:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:52:50 INFO - Using env: {'DISPLAY': ':0', 03:52:50 INFO - 'HOME': '/home/cltbld', 03:52:50 INFO - 'LANG': 'en_US.UTF-8', 03:52:50 INFO - 'LANGUAGE': 'en_US:en', 03:52:50 INFO - 'LOGNAME': 'cltbld', 03:52:50 INFO - 'MAIL': '/var/mail/cltbld', 03:52:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:50 INFO - 'MOZ_NO_REMOTE': '1', 03:52:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:50 INFO - 'NO_EM_RESTART': '1', 03:52:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:52:50 INFO - 'PWD': '/builds/slave/test-pgo', 03:52:50 INFO - 'SHELL': '/bin/bash', 03:52:50 INFO - 'SHLVL': '1', 03:52:50 INFO - 'TERM': 'linux', 03:52:50 INFO - 'TMOUT': '86400', 03:52:50 INFO - 'USER': 'cltbld', 03:52:50 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1453722744.672701-1797511328', 03:52:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:50 INFO - '_': '/tools/buildbot/bin/python'} 03:52:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:50 INFO - Downloading/unpacking jsonschema 03:52:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:52:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:52:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:52:52 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 03:52:52 INFO - Downloading/unpacking functools32 (from jsonschema) 03:52:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:52:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:52:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:52 INFO - Downloading functools32-3.2.3-2.tar.gz 03:52:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 03:52:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 03:52:52 INFO - warning: no files found matching '*.txt' 03:52:52 INFO - no previously-included directories found matching 'build' 03:52:52 INFO - no previously-included directories found matching 'dist' 03:52:52 INFO - no previously-included directories found matching '.git*' 03:52:52 INFO - Installing collected packages: jsonschema, functools32 03:52:52 INFO - Running setup.py install for functools32 03:52:53 INFO - warning: no files found matching '*.txt' 03:52:53 INFO - no previously-included directories found matching 'build' 03:52:53 INFO - no previously-included directories found matching 'dist' 03:52:53 INFO - no previously-included directories found matching '.git*' 03:52:53 INFO - Successfully installed jsonschema functools32 03:52:53 INFO - Cleaning up... 03:52:53 INFO - Return code: 0 03:52:53 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 03:52:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:52:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:52:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:53 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f710e718f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2156600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e5350>, '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 0x21e6250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21e66e0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1453722744.672701-1797511328', '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 03:52:53 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 03:52:53 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 03:52:53 INFO - Using env: {'DISPLAY': ':0', 03:52:53 INFO - 'HOME': '/home/cltbld', 03:52:53 INFO - 'LANG': 'en_US.UTF-8', 03:52:53 INFO - 'LANGUAGE': 'en_US:en', 03:52:53 INFO - 'LOGNAME': 'cltbld', 03:52:53 INFO - 'MAIL': '/var/mail/cltbld', 03:52:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:53 INFO - 'MOZ_NO_REMOTE': '1', 03:52:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:53 INFO - 'NO_EM_RESTART': '1', 03:52:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:52:53 INFO - 'PWD': '/builds/slave/test-pgo', 03:52:53 INFO - 'SHELL': '/bin/bash', 03:52:53 INFO - 'SHLVL': '1', 03:52:53 INFO - 'TERM': 'linux', 03:52:53 INFO - 'TMOUT': '86400', 03:52:53 INFO - 'USER': 'cltbld', 03:52:53 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1453722744.672701-1797511328', 03:52:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:53 INFO - '_': '/tools/buildbot/bin/python'} 03:52:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:53 INFO - Downloading/unpacking flake8 03:52:53 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 03:52:53 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 03:52:53 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 03:52:53 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 03:52:53 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 03:52:53 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 03:52:55 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:52:55 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 03:52:55 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:52:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:52:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:52:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:55 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:52:55 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 03:52:55 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:52:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:52:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:52:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:55 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 03:52:55 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:52:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:52:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:52:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.7.0.tar.gz 03:52:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 03:52:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:52:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:52:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:52:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:52:55 INFO - no previously-included directories found matching 'docs/_build' 03:52:55 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:52:55 INFO - Running setup.py install for pep8 03:52:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:52:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:52:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:52:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:52:55 INFO - no previously-included directories found matching 'docs/_build' 03:52:55 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 03:52:55 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:52:55 INFO - Cleaning up... 03:52:56 INFO - Return code: 0 03:52:56 INFO - Running post-action listener: _resource_record_post_action 03:52:56 INFO - Running post-action listener: _start_resource_monitoring 03:52:56 INFO - Starting resource monitoring. 03:52:56 INFO - ##### 03:52:56 INFO - ##### Running install step. 03:52:56 INFO - ##### 03:52:56 INFO - Running pre-action listener: _resource_record_pre_action 03:52:56 INFO - Running main action method: install 03:52:56 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:52:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:52:56 INFO - Reading from file tmpfile_stdout 03:52:56 INFO - Detecting whether we're running mozinstall >=1.0... 03:52:56 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 03:52:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 03:52:56 INFO - Reading from file tmpfile_stdout 03:52:56 INFO - Output received: 03:52:56 INFO - Usage: mozinstall [options] installer 03:52:56 INFO - Options: 03:52:56 INFO - -h, --help show this help message and exit 03:52:56 INFO - -d DEST, --destination=DEST 03:52:56 INFO - Directory to install application into. [default: 03:52:56 INFO - "/builds/slave/test-pgo"] 03:52:56 INFO - --app=APP Application being installed. [default: firefox] 03:52:56 INFO - mkdir: /builds/slave/test-pgo/build/application 03:52:56 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'] 03:52:56 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 03:53:10 INFO - Reading from file tmpfile_stdout 03:53:10 INFO - Output received: 03:53:10 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 03:53:10 INFO - Running post-action listener: _resource_record_post_action 03:53:10 INFO - ##### 03:53:10 INFO - ##### Running run-tests step. 03:53:10 INFO - ##### 03:53:10 INFO - Running pre-action listener: _resource_record_pre_action 03:53:10 INFO - Running main action method: run_tests 03:53:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 03:53:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 03:53:10 INFO - Python 2.7.3 03:53:10 INFO - Return code: 0 03:53:10 INFO - grabbing minidump binary from tooltool 03:53:10 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')]} 03:53:10 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 0x21e5350>, '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 0x21e6250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21e66e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 03:53:10 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 03:53:10 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 03:53:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:53:10 INFO - Return code: 0 03:53:10 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 03:53:10 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 03:53:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 03:53:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 03:53:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 03:53:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 03:53:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 03:53:11 INFO - Return code: 0 03:53:11 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-012', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 03:53:11 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-012 --webServer localhost 03:53:11 INFO - Using env: {'DISPLAY': ':0', 03:53:11 INFO - 'HOME': '/home/cltbld', 03:53:11 INFO - 'LANG': 'en_US.UTF-8', 03:53:11 INFO - 'LANGUAGE': 'en_US:en', 03:53:11 INFO - 'LOGNAME': 'cltbld', 03:53:11 INFO - 'MAIL': '/var/mail/cltbld', 03:53:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:53:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 03:53:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:53:11 INFO - 'MOZ_NO_REMOTE': '1', 03:53:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:53:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:53:11 INFO - 'NO_EM_RESTART': '1', 03:53:11 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:53:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:53:11 INFO - 'PWD': '/builds/slave/test-pgo', 03:53:11 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 03:53:11 INFO - 'SHELL': '/bin/bash', 03:53:11 INFO - 'SHLVL': '1', 03:53:11 INFO - 'TERM': 'linux', 03:53:11 INFO - 'TMOUT': '86400', 03:53:11 INFO - 'USER': 'cltbld', 03:53:11 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1453722744.672701-1797511328', 03:53:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:53:11 INFO - '_': '/tools/buildbot/bin/python'} 03:53:11 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-012', '--webServer', 'localhost'] with output_timeout 3600 03:53:11 INFO - mozversion INFO | application_buildid: 20160118120031 03:53:11 INFO - mozversion INFO | application_changeset: f84fcce02b11da4d97979f4151c10801ae8d9425 03:53:11 INFO - mozversion INFO | application_display_name: Nightly 03:53:11 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:53:11 INFO - mozversion INFO | application_name: Firefox 03:53:11 INFO - mozversion INFO | application_remotingname: firefox 03:53:11 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-beta 03:53:11 INFO - mozversion INFO | application_vendor: Mozilla 03:53:11 INFO - mozversion INFO | application_version: 44.0 03:53:11 INFO - mozversion INFO | platform_buildid: 20160118120031 03:53:11 INFO - mozversion INFO | platform_changeset: f84fcce02b11da4d97979f4151c10801ae8d9425 03:53:11 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-beta 03:53:11 INFO - mozversion INFO | platform_version: 44.0 03:53:11 INFO - 2016-01-25 03:53:11,878 DEBUG : using testdate: 1453722791 03:53:11 INFO - 2016-01-25 03:53:11,879 DEBUG : actual date: 1453722791 03:53:11 INFO - 2016-01-25 03:53:11,888 INFO : starting webserver on 'localhost:60306' 03:53:11 INFO - 2016-01-25 03:53:11,889 INFO : Starting test suite talos-linux64-ix-012 03:53:11 INFO - 2016-01-25 03:53:11,889 INFO : Starting test dromaeo_css 03:53:11 INFO - 2016-01-25 03:53:11,889 DEBUG : operating with platform_type : linux_ 03:53:11 INFO - 2016-01-25 03:53:11,890 INFO : Initialising browser for dromaeo_css test... 03:53:11 INFO - 2016-01-25 03:53:11,906 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpfA4qZ0/profile http://localhost:60306/getInfo.html 03:53:15 INFO - 2016-01-25 03:53:15,199 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:53:15 INFO - 2016-01-25 03:53:15,199 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:53:15 INFO - 2016-01-25 03:53:15,199 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:53:15 INFO - 2016-01-25 03:53:15,199 DEBUG : BROWSER_OUTPUT: __metrics 03:53:15 INFO - 2016-01-25 03:53:15,348 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] 03:53:16 INFO - 2016-01-25 03:53:16,365 INFO : Browser initialized. 03:53:16 INFO - 2016-01-25 03:53:16,366 INFO : Running cycle 1/1 for dromaeo_css test... 03:53:16 INFO - 2016-01-25 03:53:16,367 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpfA4qZ0/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:53:27 INFO - 2016-01-25 03:53:27,905 DEBUG : BROWSER_OUTPUT: RSS: Main: 128966656 03:53:27 INFO - 2016-01-25 03:53:27,906 DEBUG : BROWSER_OUTPUT: 03:54:18 INFO - 2016-01-25 03:54:18,953 DEBUG : BROWSER_OUTPUT: 1453722858952 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] 03:56:26 INFO - 2016-01-25 03:56:26,623 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60306/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60306/tests/dromaeo/cssquery-ext.html) 03:56:27 INFO - 2016-01-25 03:56:27,721 DEBUG : BROWSER_OUTPUT: RSS: Main: 239869952 03:56:27 INFO - 2016-01-25 03:56:27,721 DEBUG : BROWSER_OUTPUT: 03:59:29 INFO - 2016-01-25 03:59:29,816 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60306/tests/dromaeo/cssquery-ext.html (next: http://localhost:60306/tests/dromaeo/cssquery-jquery.html) 03:59:30 INFO - 2016-01-25 03:59:30,379 DEBUG : BROWSER_OUTPUT: RSS: Main: 206286848 03:59:30 INFO - 2016-01-25 03:59:30,379 DEBUG : BROWSER_OUTPUT: 04:02:32 INFO - 2016-01-25 04:02:32,070 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60306/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60306/tests/dromaeo/cssquery-mootools.html) 04:02:32 INFO - 2016-01-25 04:02:32,632 DEBUG : BROWSER_OUTPUT: RSS: Main: 195178496 04:02:32 INFO - 2016-01-25 04:02:32,632 DEBUG : BROWSER_OUTPUT: 04:05:34 INFO - 2016-01-25 04:05:34,332 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60306/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60306/tests/dromaeo/cssquery-prototype.html) 04:05:34 INFO - 2016-01-25 04:05:34,899 DEBUG : BROWSER_OUTPUT: RSS: Main: 191836160 04:05:34 INFO - 2016-01-25 04:05:34,899 DEBUG : BROWSER_OUTPUT: 04:08:37 INFO - 2016-01-25 04:08:37,274 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60306/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60306/tests/dromaeo/cssquery-yui.html) 04:08:37 INFO - 2016-01-25 04:08:37,836 DEBUG : BROWSER_OUTPUT: RSS: Main: 191225856 04:08:37 INFO - 2016-01-25 04:08:37,836 DEBUG : BROWSER_OUTPUT: 04:11:39 INFO - 2016-01-25 04:11:39,802 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60306/tests/dromaeo/cssquery-yui.html (next: http://localhost:60306/tests/dromaeo/cssquery-dojo.html) 04:11:40 INFO - 2016-01-25 04:11:40,060 DEBUG : BROWSER_OUTPUT: RSS: Main: 235278336 04:11:40 INFO - 2016-01-25 04:11:40,060 DEBUG : BROWSER_OUTPUT: 04:11:40 INFO - 2016-01-25 04:11:40,060 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:11:40 INFO - 2016-01-25 04:11:40,060 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:11:40 INFO - 2016-01-25 04:11:40,060 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:11:40 INFO - 2016-01-25 04:11:40,061 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:11:40 INFO - 2016-01-25 04:11:40,061 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3305.3058857639894;3394.372041172385;3416.5387672664183;3422.418188907887;3429.537012503312;5631.352394474631;5677.914831277524;5697.857553561163;5704.572157088214;5706.51494622957;5660.22656889973;5719.056355701315;5721.370649228582;5723.9713801431035;5734.627249228797;4953.331300274453;5161;5202.167653175493;5262.684238945675;5298.496642818926;4998.825041123561;5054.823081192159;5132.999065182291;5154.381474223099;5161.793528258884;5141.665791723544;5146.408163061258;5148.047611191922;5152.149895267276;5181.4300426953005;4992.850214493571;5139.280500729901;5147.7683504242395;5208.479152084799;5213.556847667953;5003.249512573107;5077.746112694351;5125.538701516882;5141.948580514222;5142.820001299937;5456.48163424474;5460.262864513319;5472.015037293286;5477.561795056426;5492.203630473599;5848.298204215522;5916.526677865803;6080.908786368208;6085.847853803646;6086.7565297388055;6049.395060493959;6119.5410344224365;6121.724522396503;6152.87694246117;6155.107509411155;5745.009209936783;5777.768889244425;5778.27771528559;5783.768649254025;5816.854578635525;5933.970330148321;6022.608530445507;6057.3639767824625;6231.594946328474;6261.342559031327;5964.403559644001;5966.522678185735;5967.492763115097;5970.522358211333;5982.880342393215;6041.24484439445;6058.636481811017;6060.787872424444;6062.939370606326;6065.120557519135;5785.1611516329895;5885;5972.552058595623;5989.431004054608;6121.326654068049;6024.3975602439405;6034.879302413927;6040.7583696651645;6044.455998960115;6047.546434017467;4627.95870929045;4631.814727410866;4633.72197668141;4639;4660.883477913011;4054.7769872657286;4062.370332598452;4129.8967525811495;4130.967258185454;4136.751794892316;5675.943240567624;5698.31620205578;5706.029974904276;5708.029634962067;5716.5426765859465;5848.619839710405;6074.240719910012;6076.605020673642;6079.787207447718;6081.513478921675;5549.861253468695;5612.130119831432;5632.267805185382;5650.067738823131;5676.4323567642905;5281.181416880389;5339.652922560022;5342.91985620216;5343.465653434703;5345.9465405345445;6024.3072046714315;6149.600275982047;6314.052892066226;6346.27017892939;6356.427921486996;6005.39946005396;6126.417990290915;6127.448529632355;6129.509639228941;6130.390533016695;6157.96921015392;6206.782762603287;6209.658468784261;6212.285587157535;6220.533459990428;5898.498627616529;5904.9704751475965;5972.193753843176;5982.760689572368;6015.157877897011;6067.332593414809;6069.51443884497;6071.666058366655;6079.331273559993;6098.908516372347;5910.024845900378;5913.497352725067;5914.970425148019;5921.5854890159;5921.822345329475;5791.160281759037;5818.418158184317;5883.2057672213705;5904.763809447574;5917.644941303535;5852.795152169653;5878.823635290948;5880.735366908414;5880.970595146997;5887.61730487517;5882.735276912464;5950.137230101697;5952.732127054206;5959.851003724942;5980.850478737892;5644.096944488862;5716.399778023248;5735.827925162252;5774.04728219839;5813.738381772746 04:11:40 INFO - 2016-01-25 04:11:40,061 DEBUG : BROWSER_OUTPUT: |1;ext.html;597.5458651424918;633.4710516718541;640.80135158101;643.1028714942652;644.8839208942392;36383.63616363836;42338.57661423388;42492.78753606228;42642.36036459452;42675.35986960198;45646.54353456473;46170.307445388346;46189;46199.76900115503;46245;8454.070052294273;8526.658933642648;9191.63233470662;9397.718068457923;10887.183461240398;11099.445027748621;11109.55561777532;11204.383758893258;11220.438978051106;11230.719232019224;11193.776124477505;11286.774264514705;11334.433278336091;11345.37600431976;11351.602693905716;11066.336019838795;11180.776384472305;11186.720331991684;11200.327980321206;11205.271657342328;10853.837192442119;10957.397343146124;10983.780324393467;10984.231103822736;10986.615468458565;46386.76806615979;46834.765826170995;46983;46992.7650361746;47031.29453058207;3663.8900832974787;3681.4845921571;3789.905252368685;3841.692664586826;4241.34259189826;34468.6553134468;34491.65508344909;34908.30183396318;34985.82507087474;35271;3512.2273099918234;3552.928941421157;3590.622984586633;3698.537682789651;3705.962940370589;331053;334307;334478.32760836283;335690;335754;67854.3214567858;68348.31651683518;69389;78304.43391132145;78686.6065669668;73121;73343.63328183324;73516.63241683757;73625.63187184137;73773;18229.817701823078;18600.906995464935;18627.534311642317;18642.720359194624;18678.906605467157;13818.930905345409;14033.438662453387;14069.507567235303;14073.788893166611;14119.64700882486;22857.771422285896;23044.193453229058;23159.189428370264;23202;23213.187538436072;8171.142030086874;8276.08963014068;8342.332613390914;8422.477861128657;8425.199606037417;1035.4098164046572;1036.3108532825738;1120.5405783628673;1160.6692092753524;1231.1259006105586;31566;32145;32199.195020124214;32812.343753124806;32935.67064329374;1097.3635291530893;1102.3826657071904;1137.562038615139;1184.5498710489958;1304.1457845111468;14684.559463216121;16508;16735.581610459834;17006.659866802842;17272.22274997628;405902;412675;413662;414270;416715;61889.690551546955;62171;62264.37735622586;62309;62349.68825155845;1500.5498350494809;1502.2563830903773;1504.9021813582083;1507.9924600376928;1535.3398038843404;32706.509402358508;33300.333993320484;33306.500402494465;33501.32997339991;33918.491222631186;55102.173467398825;55447.16829247484;55498.72250638721;55541.7222913899;55580.72209638926;377230;379255;379723;380456;380804;31736.841315793274;32392.190195245308;35645.82177089098;36394.11157282489;37363.813180933925;48485.75757121192;48570.271445929044;48811.755941220064;49575.752121240606;50349.24476132788;40443;40558;41104.58895411127;41669;44943.77528112339;40675.389869152576;42162.78918605387;42181;42303.36544951767;42990;39434.605653943094;41233.793831030656;41942;42118.789406052776;42537.574624253364;33093.503597445575;33495.83252083724;35147.29705405929;36282;37157.44263836099;27837.304067398476;29727.25681857971;30100;30487.542686860157;30557.694423056375 04:11:40 INFO - 2016-01-25 04:11:40,061 DEBUG : BROWSER_OUTPUT: |2;jquery.html;386.76407391491193;389.0526567807391;390.18646122833906;391.4304686680879;393.60442755031187;12582.307973061477;14998.700025999473;17628.823711762878;19324.420267391964;19332.806671933293;18991.905040474812;19091.14089865956;19233.807661923376;19396.22415103394;19757.604847903032;5649.717514124298;5796.217510636052;5801.07182850744;5806.448387403211;5819.709014549277;4452.888677783065;4614.353990441341;5761.279840019997;6290.779822706206;6478.54650174488;6125.448709616134;6346.238451385841;6385.553011289212;6408.711607977652;6431.871362572746;6480.708368123445;6489.22129344477;6500.252470965852;6529.249136349333;6530.902036469409;4395.055063161436;4475.2168370535355;5816.941830581683;5838.591298609099;5844.064949608042;14754.704905901823;14773.556793296219;14776;15070.849291507055;15316.540503784905;2025.8075482829108;2052.8049835265624;2058.279602139254;2071.388940262626;2082.552251265985;10521.526531306034;10521.78956420875;10630.521626526825;10768.838467422995;10816.188785841094;1646.1275523972313;1647.901125932436;1675.0452242221938;1694.3815507339855;1763.2418060234095;65382.3461765381;68206;68842;70183.29816701819;70256.64871675608;7616.428767842434;7689;7965.243301886311;8032.879506807402;8054.670979288352;9674.274429417821;9697.5151242439;9699;9705.466199358962;9716.95141524302;6487.0269459580495;6533.705983230766;6570.737170513222;6573.276939536647;6585.176852893388;6887.345702158287;6895.482838787111;6915.792526224222;6931;6959.930400695928;3687.94468082979;3736.8878933632036;3741.0834345584963;3765.021094515391;3765.5293088363956;1259.817326487654;1270.3965616332353;1272.1730874931184;1285.7685616589104;1311.895048396126;499.153934081728;528.2261486921678;535.3736128729396;540.7161240348848;544.2543715110324;11293.15301352402;12956.222626642431;13470.326483675777;13512.59462216135;13633.659158520917;523.9834720642018;533.8398480455847;536.0404875273296;547.1437200780765;559.3623269472804;6803.625800580917;6885.277045910208;7075.787726368218;7105.82235444118;7124.358807707331;679655;682923;695259;698210;726310;47020.529794701615;47164.5283547167;65988.01017984735;79205;87008.5649571748;511.75435790820615;525.3433208489388;528.2762615217177;528.5877015927582;530.0882482130729;10721.30311529748;11047.72380690489;11053.226274160732;11192.272502287326;11245.32528048287;39193;39706.40440393454;40436;40518.987025324604;41483.37774933439;53009.20486192787;53773.731131344095;53796.46203537915;54018.729906351786;54416.72791636016;9133.817323653622;9242.12199841014;9370.578323975575;9447.527623618655;9664.178544823768;11554.306741595532;13340.533081342495;13762.65593360174;13853.861461385257;13879.375428105557;11939.76120477603;11989.160758746804;12041.819372709591;12066.276023438622;12201.755964880474;11670.241434306743;11916.404179791149;11960.46177922013;11997.820032699341;12043.09676774228;11849.229800062969;11927.582534611247;12054.397280136134;12208.694782630506;12292.262464252173;9319.254459643076;9328.673496427593;9342.065793420876;9410.43537387759;9420.481873497023;11444.599439019594;11932.105092117952;12392.31842248685;12684.87315126874;12787.168834025759 04:11:40 INFO - 2016-01-25 04:11:40,061 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1597.6005998500375;1599.4561848971355;1848.3900312896747;1859.7117446795746;1895.1282410091362;7491.438142139334;7630.732924347649;7964.681412743491;8129.30900873425;8130.065042520112;7924.881126783102;8090.069641991173;8144.91855081449;8154.91845081549;8167.18328167183;2386.331827088414;2417.540667273221;2419.11702228687;2420.9515809683794;2421.4188594737225;2161.167950339115;2196.4728465168323;2361.822863285252;2436.671049408325;2441.206607852455;2333.684952531412;2345.64815277708;2349.0368948731025;2360.3509035015422;2361.445060410802;2440.694913135858;2453.251758213762;2459.717132529764;2462.507498500298;2465.8520488770732;2403.3631087761755;2460.778529932297;2461.4953934443397;2462.7660372264604;2463.692038495188;8379.581020948988;8453.365997550147;8463.788405289917;8466.32269418445;8487.872681909776;5066.341375621182;5130.179171332569;5141.897162056775;5147.922781158286;5148.742562871841;3243.172990887332;3288.2108294009504;3333.7166340861054;3355.1612096975755;3362.277110421271;1081.5944020992129;1096.9396683182422;1111.522045520426;1118.7538741476862;1122.966311010671;11469.025132863717;11486.081113510983;11491.65525034242;11611.535538578446;11681.532738690443;4599.310103484504;4603.572892403366;4654.720716757005;4661.836835710734;4665.626749860003;9870.407775533491;9884.950575247078;9900.405975641484;9905.80188396228;9918.752031199134;5138.743062846843;5157.355330583677;5170.1986192140275;5174.456682048406;5174.534291913746;4669.696469729524;4702;4707.717536947725;4729.6689231754135;4754.738489383048;3468.0462872709704;4013.7792421417103;4022.7586344819406;4023.195360927826;4034.3545032794614;1218.8049912014035;1270.7458508298378;1272.993635031819;1285.13895689888;1293.4567481657725;1197.988020119805;1364.7134101838726;1405.3184205660248;1425.8075159853288;1443.8449240607472;7789.7273595423885;7826.530408175528;7829.569373684502;7842.764717058498;7883.093444253869;1200.7478429529897;1218.713602303458;1220.0422668205417;1220.9328486933127;1226.7730469862925;6267.310595834455;6331.810045698637;6388.904166437507;6420.165378500765;6433.935660643428;9824.410535367759;10114.393136411838;10127.898721012843;10130.848037279447;10135.442550659785;9839.55721992512;9997.100260976547;10009.649662261785;10018.3488073275;10055.39667619945;7856.646450909723;7859.764207073797;7911.485753426009;7918.168592297841;7927.167647397056;7512.849743005218;7528.284812942762;7555.848883022419;7584.848303033798;7606.087269527692;8658.826823463369;8861.822763544564;8880.73357799267;8891;8975.32685048637;8948.642054317754;8974.955125224593;9021.323400745101;9030.503322317336;9246.815063698554;7492;7525.849483010418;7580.507267027626;7587.772366829004;7589.468737188344;7250.383717384081;7406.8148296290865;8058.959705201437;8093.988251468566;8118.959405202936;7354.521956072838;7390.187079421152;7423.591702456417;7502.512336698097;7524.924750752422;7331.193568707331;7382.224866388952;7385;7432.145303290191;7495.850082998419;7391.1869694334655;7419.740309089156;7462.850742985219;7464.328210461084;7474.177840437656;6887.965560172367;6935.306469353024;6935.895961560682;6940.340667636567;6949;6791;6843.178818541807;6857.108575885103;6868.62222577763;6873.518853680194 04:11:40 INFO - 2016-01-25 04:11:40,061 DEBUG : BROWSER_OUTPUT: |4;prototype.html;355.19371027766965;357.7603005985989;366.7286208205925;370.7367768884092;375.3974870333115;5890.705464726757;5955.344912059675;5965.791197308095;5998.490128339096;6022.939770602293;5776.249087618614;5869.589128760988;5873.11903214518;5873.735681894314;5917.408259174081;4625.745583992879;4627.259638457847;4637.466691330506;4639.095376401595;4644.86065418038;4460.687751857371;4527.750973696446;4581.885452863672;4645.396098507206;4656.883577910562;4591.885202869921;4597.42532183477;4600.033992861487;4604.953950460503;4619.676622636417;4596.954030459686;4600.286955521883;4604.493505714386;4607.838725644587;4612.0545288215835;4107.609777071173;4110.876673699794;4111.71218014739;4117.485314335708;4118.908489250351;5546.889062218774;5603.299587551556;5625.071863142576;5681.403452637455;5682.886342273131;5405.27028851104;5409.594280428983;5409.702466364349;5412.107002344648;5417.024935511607;6039.1545183674325;6317.4946004319545;6324.083007963865;6324.430801227865;6327.778527751552;4428.844990425319;4463.68754187207;4539.296409056601;4542.4776150742755;4543.409356783597;6410;6413.518986076063;6425.646589437579;6431.09964604951;6431.389018043325;4631.884202894955;4636.095961287517;4636.397268355092;4640.466346370211;4642.0715856828765;4632.490426053131;4708.034852855157;4712.387389639325;4746.833860814855;4786.44955830084;5405.297311349499;5406.702631355313;5412.621116521806;5414.7834086636885;5421.213923981;6353.777617783356;6357.014662727192;6357.300696923335;6359.300476947532;6359.491240700733;1684.082175214511;1727.3608764756868;1727.9481615551554;1731.8527925126252;1732.7400889866622;1168.1764356128908;1174.565410797993;1175.1421462332546;1180.055955235808;1208.2931485081326;6136.693165341715;6136.815895523141;6140.907886381708;6145.723442445012;6152.692365381713;6545.967270163619;6546.869062618721;6547.9017814732815;6550.050242714875;6555.639439830855;6001.879962400815;6131.540134489931;6140.692965351804;6142.140100385949;6147.385261473906;3589.407747721649;3610.223801882608;3611.638836116367;3614.87347942826;3618.4210526316187;6691.197056353171;6694.631795251308;6701.028350889093;6702.061711360413;6702.664866756642;6609.20689517261;6697.196336439659;6700.664966751643;6708.631025293558;6712.093867327946;6679.632620205838;6680.966595166993;6685.331466853373;6694.866102678016;6698.229703584053;6321.431071203614;6404.295527491879;6521.34786521363;6525.608463492205;6533.248676402274;6344.270408903035;6411.5832470889245;6437.935620643733;6438.742450301936;6453.677316134081;6639.203295604559;6641.402273795382;6647.202335719745;6654.534182607171;6658.6337751424135;4599.942013337019;4627.537246275346;4662.580367766917;4663.930041049455;4730.739809310521;6601.966990165019;6604.075429439787;6606.669666516559;6611.173603299588;6617.636030018395;6337.7781777637565;6409.102725618511;6409.35906409374;6418.19772528434;6419.807405777834;6264.279607844974;6335;6412.871742565216;6414.839629009125;6421.550491465552;6312.652804095819;6316.778912738032;6317.241930968313;6327.873442531031;6329.272133704683;6384.6169229846355;6404.071409645482;6429.646369449725;6455.903161452676;6461.64460954652;6173.259208894781;6260.718267678057;6266.310705822265;6300.495960323255;6308.589941653778 04:11:40 INFO - 2016-01-25 04:11:40,062 DEBUG : BROWSER_OUTPUT: |5;yui.html;927.2813569483653;939.0656296984502;943.6602822983725;946.460517505022;952.8046750416163;13083.607491775238;13372.264525451097;13388.53140140093;13393.665158371034;13398.799018014726;14241;14341.713165736679;14361.28193590319;14367;14375.424983000667;767.2059418501851;771.2788542712553;916.9908300916973;929.6281487405024;933.0389698610442;911.6399022386187;912.3750231091724;912.434290739739;918.5407296351824;918.5958178401515;813.5525460996458;962.37445660321;969.6557722008691;969.6557722008691;970.2480577552383;808.59974312715;946.5693109635134;954.0316578672653;960.6397600899662;963.7686955130788;718.1884470548247;718.8167017410527;719.3993015831787;719.7480881691419;720.103471178381;14217.146971181763;14343.139411635335;14381.28093595316;14382.928085359506;14384.64038399038;12736.872631273662;12842.743145137138;12909.806352904714;12951.48194072236;12986.805197922038;10002.59989600415;10039.69880903574;10069.89930100697;10127.797444051077;10166.542505587193;3330.7501937354555;3386.356592247465;3389.4915762635555;3392.5759280089987;3395.6434574369828;53191.734041329546;53380.19929701058;53420;56767.14849277264;56993.14510282307;9622.51887405627;9656.903430965742;9663.082007209305;9683;9712.22302215821;20982;21048.894755526126;21222.681659775117;21370;21382.144714211256;7449.925500745032;7565.773026809205;7571.46999710026;7595.5442673439775;7632.542047477169;4091.488563929509;4111.465509483748;4144.958550414457;4145.585441455831;4173.31140361843;3375.1393394684687;3416.128887133765;3419.2990436960363;3426.434638284655;3429.3655673700446;473.9123262196505;495.1631742355408;496.4638190753977;555.6166245290736;570.3469527391114;538.2330179494205;559.8180591307841;608.656109298245;633.6261605652595;642.9549931504844;7092.503524753218;7215.60314182725;7272.527285726411;7307.212229410913;7500.737474188377;565.6775637886448;611.248164757351;615.4737699267151;617.4998251416367;633.7781776378231;3977.980110099431;3980.661643760313;4019.9196016079513;4105.692073094529;4109.0959988802415;62220;70160;70511;70755.64622176856;70889.64555177192;54370;55486.72256638691;55487.16769248465;56092.719536402874;56337;50706.23940640893;50935;51453.48546514487;51869.7406512965;52649.2102618461;8242.340612750846;8260.256576908107;8353.164683531599;8485.490870547786;8560.143985601639;38086;39167;39205.2158956825;41082.17835643211;41203.38194927138;52247.21629175489;52342.21486677627;52849;52980.20529692135;53032.73483632557;8439.746807595782;8666.263367613823;8738.475691458532;8740.431871928304;8761.342899282452;12202.938985305016;12306.07704422154;12375;12556.87443125557;12716.618501444971;10472.214583906085;10614.681559553226;10734.677959661223;10777.676669699922;10885.727856803644;11533;11858.525658973544;11926.224795388272;11968.46141923598;12455.688607784516;10771.569137234736;11110.000099991039;11239.269447485887;11728;11851.170418070997;10214.642487512901;10349.223808214565;10441.269111162146;11134.832977505182;11152.442377881236;9013.954930225307;9262.351635385457;9298.39560428597;9304.255659547085;9385.38994965325 04:11:40 INFO - 2016-01-25 04:11:40,062 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:11:40 INFO - 2016-01-25 04:11:40,062 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:11:40 INFO - 2016-01-25 04:11:40,062 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,846 04:11:40 INFO - 2016-01-25 04:11:40,062 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:11:40 INFO - 2016-01-25 04:11:40,063 DEBUG : BROWSER_OUTPUT: __startTimestamp1453723900055__endTimestamp 04:11:40 INFO - 2016-01-25 04:11:40,063 DEBUG : BROWSER_OUTPUT: 04:11:40 INFO - 2016-01-25 04:11:40,063 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:11:40 INFO - 2016-01-25 04:11:40,063 DEBUG : BROWSER_OUTPUT: Number of tests: 6 04:11:40 INFO - 2016-01-25 04:11:40,063 DEBUG : BROWSER_OUTPUT: 04:11:40 INFO - 2016-01-25 04:11:40,063 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5614.99 Median:5818.42 stddev:621.67 (10.7%) stddev-sans-first:596.59 04:11:40 INFO - 2016-01-25 04:11:40,063 DEBUG : BROWSER_OUTPUT: Values: 3305.3 3394.4 3416.5 3422.4 3429.5 5631.4 5677.9 5697.9 5704.6 5706.5 5660.2 5719.1 5721.4 5724.0 5734.6 4953.3 5161.0 5202.2 5262.7 5298.5 4998.8 5054.8 5133.0 5154.4 5161.8 5141.7 5146.4 5148.0 5152.1 5181.4 4992.9 5139.3 5147.8 5208.5 5213.6 5003.2 5077.7 5125.5 5141.9 5142.8 5456.5 5460.3 5472.0 5477.6 5492.2 5848.3 5916.5 6080.9 6085.8 6086.8 6049.4 6119.5 6121.7 6152.9 6155.1 5745.0 5777.8 5778.3 5783.8 5816.9 5934.0 6022.6 6057.4 6231.6 6261.3 5964.4 5966.5 5967.5 5970.5 5982.9 6041.2 6058.6 6060.8 6062.9 6065.1 5785.2 5885.0 5972.6 5989.4 6121.3 6024.4 6034.9 6040.8 6044.5 6047.5 4628.0 4631.8 4633.7 4639.0 4660.9 4054.8 4062.4 4129.9 4131.0 4136.8 5675.9 5698.3 5706.0 5708.0 5716.5 5848.6 6074.2 6076.6 6079.8 6081.5 5549.9 5612.1 5632.3 5650.1 5676.4 5281.2 5339.7 5342.9 5343.5 5345.9 6024.3 6149.6 6314.1 6346.3 6356.4 6005.4 6126.4 6127.4 6129.5 6130.4 6158.0 6206.8 6209.7 6212.3 6220.5 5898.5 5905.0 5972.2 5982.8 6015.2 6067.3 6069.5 6071.7 6079.3 6098.9 5910.0 5913.5 5915.0 5921.6 5921.8 5791.2 5818.4 5883.2 5904.8 5917.6 5852.8 5878.8 5880.7 5881.0 5887.6 5882.7 5950.1 5952.7 5959.9 5980.9 5644.1 5716.4 5735.8 5774.0 5813.7 04:11:40 INFO - 2016-01-25 04:11:40,063 DEBUG : BROWSER_OUTPUT: 04:11:40 INFO - 2016-01-25 04:11:40,063 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:56802.13 Median:36332.82 stddev:98864.62 (272.1%) stddev-sans-first:99051.90 04:11:40 INFO - 2016-01-25 04:11:40,064 DEBUG : BROWSER_OUTPUT: Values: 597.5 633.5 640.8 643.1 644.9 36383.6 42338.6 42492.8 42642.4 42675.4 45646.5 46170.3 46189.0 46199.8 46245.0 8454.1 8526.7 9191.6 9397.7 10887.2 11099.4 11109.6 11204.4 11220.4 11230.7 11193.8 11286.8 11334.4 11345.4 11351.6 11066.3 11180.8 11186.7 11200.3 11205.3 10853.8 10957.4 10983.8 10984.2 10986.6 46386.8 46834.8 46983.0 46992.8 47031.3 3663.9 3681.5 3789.9 3841.7 4241.3 34468.7 34491.7 34908.3 34985.8 35271.0 3512.2 3552.9 3590.6 3698.5 3706.0 331053.0 334307.0 334478.3 335690.0 335754.0 67854.3 68348.3 69389.0 78304.4 78686.6 73121.0 73343.6 73516.6 73625.6 73773.0 18229.8 18600.9 18627.5 18642.7 18678.9 13818.9 14033.4 14069.5 14073.8 14119.6 22857.8 23044.2 23159.2 23202.0 23213.2 8171.1 8276.1 8342.3 8422.5 8425.2 1035.4 1036.3 1120.5 1160.7 1231.1 31566.0 32145.0 32199.2 32812.3 32935.7 1097.4 1102.4 1137.6 1184.5 1304.1 14684.6 16508.0 16735.6 17006.7 17272.2 405902.0 412675.0 413662.0 414270.0 416715.0 61889.7 62171.0 62264.4 62309.0 62349.7 1500.5 1502.3 1504.9 1508.0 1535.3 32706.5 33300.3 33306.5 33501.3 33918.5 55102.2 55447.2 55498.7 55541.7 55580.7 377230.0 379255.0 379723.0 380456.0 380804.0 31736.8 32392.2 35645.8 36394.1 37363.8 48485.8 48570.3 48811.8 49575.8 50349.2 40443.0 40558.0 41104.6 41669.0 44943.8 40675.4 42162.8 42181.0 42303.4 42990.0 39434.6 41233.8 41942.0 42118.8 42537.6 33093.5 33495.8 35147.3 36282.0 37157.4 27837.3 29727.3 30100.0 30487.5 30557.7 04:11:40 INFO - 2016-01-25 04:11:40,065 DEBUG : BROWSER_OUTPUT: 04:11:40 INFO - 2016-01-25 04:11:40,065 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:32460.24 Median:23831.84 stddev:113831.34 (477.6%) stddev-sans-first:114125.18 04:11:40 INFO - 2016-01-25 04:11:40,065 DEBUG : BROWSER_OUTPUT: Values: 386.8 389.1 390.2 391.4 393.6 12582.3 14998.7 17628.8 19324.4 19332.8 18991.9 19091.1 19233.8 19396.2 19757.6 5649.7 5796.2 5801.1 5806.4 5819.7 4452.9 4614.4 5761.3 6290.8 6478.5 6125.4 6346.2 6385.6 6408.7 6431.9 6480.7 6489.2 6500.3 6529.2 6530.9 4395.1 4475.2 5816.9 5838.6 5844.1 14754.7 14773.6 14776.0 15070.8 15316.5 2025.8 2052.8 2058.3 2071.4 2082.6 10521.5 10521.8 10630.5 10768.8 10816.2 1646.1 1647.9 1675.0 1694.4 1763.2 65382.3 68206.0 68842.0 70183.3 70256.6 7616.4 7689.0 7965.2 8032.9 8054.7 9674.3 9697.5 9699.0 9705.5 9717.0 6487.0 6533.7 6570.7 6573.3 6585.2 6887.3 6895.5 6915.8 6931.0 6959.9 3687.9 3736.9 3741.1 3765.0 3765.5 1259.8 1270.4 1272.2 1285.8 1311.9 499.2 528.2 535.4 540.7 544.3 11293.2 12956.2 13470.3 13512.6 13633.7 524.0 533.8 536.0 547.1 559.4 6803.6 6885.3 7075.8 7105.8 7124.4 679655.0 682923.0 695259.0 698210.0 726310.0 47020.5 47164.5 65988.0 79205.0 87008.6 511.8 525.3 528.3 528.6 530.1 10721.3 11047.7 11053.2 11192.3 11245.3 39193.0 39706.4 40436.0 40519.0 41483.4 53009.2 53773.7 53796.5 54018.7 54416.7 9133.8 9242.1 9370.6 9447.5 9664.2 11554.3 13340.5 13762.7 13853.9 13879.4 11939.8 11989.2 12041.8 12066.3 12201.8 11670.2 11916.4 11960.5 11997.8 12043.1 11849.2 11927.6 12054.4 12208.7 12292.3 9319.3 9328.7 9342.1 9410.4 9420.5 11444.6 11932.1 12392.3 12684.9 12787.2 04:11:40 INFO - 2016-01-25 04:11:40,065 DEBUG : BROWSER_OUTPUT: 04:11:40 INFO - 2016-01-25 04:11:40,065 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5845.71 Median:5174.50 stddev:2999.56 (58.0%) stddev-sans-first:2990.98 04:11:40 INFO - 2016-01-25 04:11:40,065 DEBUG : BROWSER_OUTPUT: Values: 1597.6 1599.5 1848.4 1859.7 1895.1 7491.4 7630.7 7964.7 8129.3 8130.1 7924.9 8090.1 8144.9 8154.9 8167.2 2386.3 2417.5 2419.1 2421.0 2421.4 2161.2 2196.5 2361.8 2436.7 2441.2 2333.7 2345.6 2349.0 2360.4 2361.4 2440.7 2453.3 2459.7 2462.5 2465.9 2403.4 2460.8 2461.5 2462.8 2463.7 8379.6 8453.4 8463.8 8466.3 8487.9 5066.3 5130.2 5141.9 5147.9 5148.7 3243.2 3288.2 3333.7 3355.2 3362.3 1081.6 1096.9 1111.5 1118.8 1123.0 11469.0 11486.1 11491.7 11611.5 11681.5 4599.3 4603.6 4654.7 4661.8 4665.6 9870.4 9885.0 9900.4 9905.8 9918.8 5138.7 5157.4 5170.2 5174.5 5174.5 4669.7 4702.0 4707.7 4729.7 4754.7 3468.0 4013.8 4022.8 4023.2 4034.4 1218.8 1270.7 1273.0 1285.1 1293.5 1198.0 1364.7 1405.3 1425.8 1443.8 7789.7 7826.5 7829.6 7842.8 7883.1 1200.7 1218.7 1220.0 1220.9 1226.8 6267.3 6331.8 6388.9 6420.2 6433.9 9824.4 10114.4 10127.9 10130.8 10135.4 9839.6 9997.1 10009.6 10018.3 10055.4 7856.6 7859.8 7911.5 7918.2 7927.2 7512.8 7528.3 7555.8 7584.8 7606.1 8658.8 8861.8 8880.7 8891.0 8975.3 8948.6 8975.0 9021.3 9030.5 9246.8 7492.0 7525.8 7580.5 7587.8 7589.5 7250.4 7406.8 8059.0 8094.0 8119.0 7354.5 7390.2 7423.6 7502.5 7524.9 7331.2 7382.2 7385.0 7432.1 7495.9 7391.2 7419.7 7462.9 7464.3 7474.2 6888.0 6935.3 6935.9 6940.3 6949.0 6791.0 6843.2 6857.1 6868.6 6873.5 04:11:40 INFO - 2016-01-25 04:11:40,065 DEBUG : BROWSER_OUTPUT: 04:11:40 INFO - 2016-01-25 04:11:40,065 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5334.34 Median:6031.05 stddev:1557.33 (25.8%) stddev-sans-first:1516.19 04:11:40 INFO - 2016-01-25 04:11:40,067 DEBUG : BROWSER_OUTPUT: Values: 355.2 357.8 366.7 370.7 375.4 5890.7 5955.3 5965.8 5998.5 6022.9 5776.2 5869.6 5873.1 5873.7 5917.4 4625.7 4627.3 4637.5 4639.1 4644.9 4460.7 4527.8 4581.9 4645.4 4656.9 4591.9 4597.4 4600.0 4605.0 4619.7 4597.0 4600.3 4604.5 4607.8 4612.1 4107.6 4110.9 4111.7 4117.5 4118.9 5546.9 5603.3 5625.1 5681.4 5682.9 5405.3 5409.6 5409.7 5412.1 5417.0 6039.2 6317.5 6324.1 6324.4 6327.8 4428.8 4463.7 4539.3 4542.5 4543.4 6410.0 6413.5 6425.6 6431.1 6431.4 4631.9 4636.1 4636.4 4640.5 4642.1 4632.5 4708.0 4712.4 4746.8 4786.4 5405.3 5406.7 5412.6 5414.8 5421.2 6353.8 6357.0 6357.3 6359.3 6359.5 1684.1 1727.4 1727.9 1731.9 1732.7 1168.2 1174.6 1175.1 1180.1 1208.3 6136.7 6136.8 6140.9 6145.7 6152.7 6546.0 6546.9 6547.9 6550.1 6555.6 6001.9 6131.5 6140.7 6142.1 6147.4 3589.4 3610.2 3611.6 3614.9 3618.4 6691.2 6694.6 6701.0 6702.1 6702.7 6609.2 6697.2 6700.7 6708.6 6712.1 6679.6 6681.0 6685.3 6694.9 6698.2 6321.4 6404.3 6521.3 6525.6 6533.2 6344.3 6411.6 6437.9 6438.7 6453.7 6639.2 6641.4 6647.2 6654.5 6658.6 4599.9 4627.5 4662.6 4663.9 4730.7 6602.0 6604.1 6606.7 6611.2 6617.6 6337.8 6409.1 6409.4 6418.2 6419.8 6264.3 6335.0 6412.9 6414.8 6421.6 6312.7 6316.8 6317.2 6327.9 6329.3 6384.6 6404.1 6429.6 6455.9 6461.6 6173.3 6260.7 6266.3 6300.5 6308.6 04:11:40 INFO - 2016-01-25 04:11:40,067 DEBUG : BROWSER_OUTPUT: 04:11:40 INFO - 2016-01-25 04:11:40,067 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14978.50 Median:52914.60 stddev:18490.78 (34.9%) stddev-sans-first:18512.54 04:11:40 INFO - 2016-01-25 04:11:40,067 DEBUG : BROWSER_OUTPUT: Values: 927.3 939.1 943.7 946.5 952.8 13083.6 13372.3 13388.5 13393.7 13398.8 14241.0 14341.7 14361.3 14367.0 14375.4 767.2 771.3 917.0 929.6 933.0 911.6 912.4 912.4 918.5 918.6 813.6 962.4 969.7 969.7 970.2 808.6 946.6 954.0 960.6 963.8 718.2 718.8 719.4 719.7 720.1 14217.1 14343.1 14381.3 14382.9 14384.6 12736.9 12842.7 12909.8 12951.5 12986.8 10002.6 10039.7 10069.9 10127.8 10166.5 3330.8 3386.4 3389.5 3392.6 3395.6 53191.7 53380.2 53420.0 56767.1 56993.1 9622.5 9656.9 9663.1 9683.0 9712.2 20982.0 21048.9 21222.7 21370.0 21382.1 7449.9 7565.8 7571.5 7595.5 7632.5 4091.5 4111.5 4145.0 4145.6 4173.3 3375.1 3416.1 3419.3 3426.4 3429.4 473.9 495.2 496.5 555.6 570.3 538.2 559.8 608.7 633.6 643.0 7092.5 7215.6 7272.5 7307.2 7500.7 565.7 611.2 615.5 617.5 633.8 3978.0 3980.7 4019.9 4105.7 4109.1 62220.0 70160.0 70511.0 70755.6 70889.6 54370.0 55486.7 55487.2 56092.7 56337.0 50706.2 50935.0 51453.5 51869.7 52649.2 8242.3 8260.3 8353.2 8485.5 8560.1 38086.0 39167.0 39205.2 41082.2 41203.4 52247.2 52342.2 52849.0 52980.2 53032.7 8439.7 8666.3 8738.5 8740.4 8761.3 12202.9 12306.1 12375.0 12556.9 12716.6 10472.2 10614.7 10734.7 10777.7 10885.7 11533.0 11858.5 11926.2 11968.5 12455.7 10771.6 11110.0 11239.3 11728.0 11851.2 10214.6 10349.2 10441.3 11134.8 11152.4 9014.0 9262.4 9298.4 9304.3 9385.4 04:11:40 INFO - 2016-01-25 04:11:40,067 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:11:40 INFO - 2016-01-25 04:11:40,067 DEBUG : BROWSER_OUTPUT: 04:11:40 INFO - 2016-01-25 04:11:40,614 INFO : Browser exited with error code: 0 04:11:40 INFO - 2016-01-25 04:11:40,629 INFO : Completed test dromaeo_css (00:18:28) 04:11:40 INFO - 2016-01-25 04:11:40,630 INFO : Starting test kraken 04:11:40 INFO - 2016-01-25 04:11:40,630 DEBUG : operating with platform_type : linux_ 04:11:40 INFO - 2016-01-25 04:11:40,630 INFO : Initialising browser for kraken test... 04:11:40 INFO - 2016-01-25 04:11:40,636 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp5oqlju/profile http://localhost:60306/getInfo.html 04:11:43 INFO - 2016-01-25 04:11:43,684 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:11:43 INFO - 2016-01-25 04:11:43,684 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:11:43 INFO - 2016-01-25 04:11:43,684 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:11:43 INFO - 2016-01-25 04:11:43,684 DEBUG : BROWSER_OUTPUT: __metrics 04:11:43 INFO - 2016-01-25 04:11:43,761 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] 04:11:44 INFO - 2016-01-25 04:11:44,889 INFO : Browser initialized. 04:11:44 INFO - 2016-01-25 04:11:44,890 INFO : Running cycle 1/1 for kraken test... 04:11:44 INFO - 2016-01-25 04:11:44,890 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp5oqlju/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:11:56 INFO - 2016-01-25 04:11:56,427 DEBUG : BROWSER_OUTPUT: RSS: Main: 128888832 04:11:56 INFO - 2016-01-25 04:11:56,427 DEBUG : BROWSER_OUTPUT: 04:11:58 INFO - 2016-01-25 04:11:58,847 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60306/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60306/tests/kraken/driver.html?testName=audio-beat-detection) 04:11:59 INFO - 2016-01-25 04:11:59,414 DEBUG : BROWSER_OUTPUT: RSS: Main: 163745792 04:11:59 INFO - 2016-01-25 04:11:59,414 DEBUG : BROWSER_OUTPUT: 04:12:01 INFO - 2016-01-25 04:12:01,991 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60306/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60306/tests/kraken/driver.html?testName=audio-dft) 04:12:02 INFO - 2016-01-25 04:12:02,553 DEBUG : BROWSER_OUTPUT: RSS: Main: 159555584 04:12:02 INFO - 2016-01-25 04:12:02,553 DEBUG : BROWSER_OUTPUT: 04:12:05 INFO - 2016-01-25 04:12:05,311 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60306/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60306/tests/kraken/driver.html?testName=audio-fft) 04:12:05 INFO - 2016-01-25 04:12:05,873 DEBUG : BROWSER_OUTPUT: RSS: Main: 157425664 04:12:05 INFO - 2016-01-25 04:12:05,873 DEBUG : BROWSER_OUTPUT: 04:12:07 INFO - 2016-01-25 04:12:07,798 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60306/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60306/tests/kraken/driver.html?testName=audio-oscillator) 04:12:08 INFO - 2016-01-25 04:12:08,359 DEBUG : BROWSER_OUTPUT: RSS: Main: 156758016 04:12:08 INFO - 2016-01-25 04:12:08,359 DEBUG : BROWSER_OUTPUT: 04:12:10 INFO - 2016-01-25 04:12:10,514 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60306/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60306/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:12:11 INFO - 2016-01-25 04:12:11,063 DEBUG : BROWSER_OUTPUT: RSS: Main: 154882048 04:12:11 INFO - 2016-01-25 04:12:11,064 DEBUG : BROWSER_OUTPUT: 04:12:13 INFO - 2016-01-25 04:12:13,915 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60306/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60306/tests/kraken/driver.html?testName=imaging-darkroom) 04:12:14 INFO - 2016-01-25 04:12:14,496 DEBUG : BROWSER_OUTPUT: RSS: Main: 155295744 04:12:14 INFO - 2016-01-25 04:12:14,496 DEBUG : BROWSER_OUTPUT: 04:12:17 INFO - 2016-01-25 04:12:17,821 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60306/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60306/tests/kraken/driver.html?testName=imaging-desaturate) 04:12:18 INFO - 2016-01-25 04:12:18,382 DEBUG : BROWSER_OUTPUT: RSS: Main: 156352512 04:12:18 INFO - 2016-01-25 04:12:18,382 DEBUG : BROWSER_OUTPUT: 04:12:21 INFO - 2016-01-25 04:12:21,141 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60306/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60306/tests/kraken/driver.html?testName=json-parse-financial) 04:12:21 INFO - 2016-01-25 04:12:21,703 DEBUG : BROWSER_OUTPUT: RSS: Main: 154181632 04:12:21 INFO - 2016-01-25 04:12:21,703 DEBUG : BROWSER_OUTPUT: 04:12:23 INFO - 2016-01-25 04:12:23,199 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60306/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60306/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:12:23 INFO - 2016-01-25 04:12:23,760 DEBUG : BROWSER_OUTPUT: RSS: Main: 161501184 04:12:23 INFO - 2016-01-25 04:12:23,761 DEBUG : BROWSER_OUTPUT: 04:12:25 INFO - 2016-01-25 04:12:25,475 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60306/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60306/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:12:26 INFO - 2016-01-25 04:12:26,061 DEBUG : BROWSER_OUTPUT: RSS: Main: 160251904 04:12:26 INFO - 2016-01-25 04:12:26,061 DEBUG : BROWSER_OUTPUT: 04:12:28 INFO - 2016-01-25 04:12:28,035 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60306/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60306/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:12:28 INFO - 2016-01-25 04:12:28,596 DEBUG : BROWSER_OUTPUT: RSS: Main: 166215680 04:12:28 INFO - 2016-01-25 04:12:28,596 DEBUG : BROWSER_OUTPUT: 04:12:30 INFO - 2016-01-25 04:12:30,952 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60306/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60306/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:12:31 INFO - 2016-01-25 04:12:31,525 DEBUG : BROWSER_OUTPUT: RSS: Main: 171438080 04:12:31 INFO - 2016-01-25 04:12:31,525 DEBUG : BROWSER_OUTPUT: 04:12:33 INFO - 2016-01-25 04:12:33,912 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60306/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60306/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:12:34 INFO - 2016-01-25 04:12:34,475 DEBUG : BROWSER_OUTPUT: RSS: Main: 168828928 04:12:34 INFO - 2016-01-25 04:12:34,475 DEBUG : BROWSER_OUTPUT: 04:12:36 INFO - 2016-01-25 04:12:36,083 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60306/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60306/tests/kraken/driver.html?testName=ai-astar) 04:12:36 INFO - 2016-01-25 04:12:36,341 DEBUG : BROWSER_OUTPUT: RSS: Main: 228884480 04:12:36 INFO - 2016-01-25 04:12:36,341 DEBUG : BROWSER_OUTPUT: 04:12:36 INFO - 2016-01-25 04:12:36,341 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:12:36 INFO - 2016-01-25 04:12:36,341 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:12:36 INFO - 2016-01-25 04:12:36,341 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:12:36 INFO - 2016-01-25 04:12:36,341 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:12:36 INFO - 2016-01-25 04:12:36,341 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;110;103;108;109;109;100;108;106;109 04:12:36 INFO - 2016-01-25 04:12:36,341 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;153;120;142;164;131;158;145;125;166;129 04:12:36 INFO - 2016-01-25 04:12:36,341 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;160;159;160;157;160;158;162;160;158 04:12:36 INFO - 2016-01-25 04:12:36,341 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;70;71;139;70;72;72;70;153;71 04:12:36 INFO - 2016-01-25 04:12:36,341 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;88;87;129;89;90;90;135;89;90;141 04:12:36 INFO - 2016-01-25 04:12:36,341 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;111;110;110;111;110;110;109 04:12:36 INFO - 2016-01-25 04:12:36,342 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;145;146;145;146;146;147;145;146;145 04:12:36 INFO - 2016-01-25 04:12:36,342 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;96;95;95;95;95;96;96;97 04:12:36 INFO - 2016-01-25 04:12:36,342 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;55;56;55;55;56;55;56;57;56;53 04:12:36 INFO - 2016-01-25 04:12:36,342 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;63;63;63;63;63;62;62;63;62;63 04:12:36 INFO - 2016-01-25 04:12:36,342 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;77;76;78;77;79;77;77;76;77;76 04:12:36 INFO - 2016-01-25 04:12:36,342 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;123;106;115;118;118;109;114;114;108;125 04:12:36 INFO - 2016-01-25 04:12:36,342 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;137;142;125;135;135;135;127;137;137;134 04:12:36 INFO - 2016-01-25 04:12:36,342 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;61;64;64;61;62;62;62;61;64;60 04:12:36 INFO - 2016-01-25 04:12:36,343 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:12:36 INFO - 2016-01-25 04:12:36,343 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:12:36 INFO - 2016-01-25 04:12:36,343 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,859 04:12:36 INFO - 2016-01-25 04:12:36,343 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:12:36 INFO - 2016-01-25 04:12:36,343 DEBUG : BROWSER_OUTPUT: __startTimestamp1453723956335__endTimestamp 04:12:36 INFO - 2016-01-25 04:12:36,343 DEBUG : BROWSER_OUTPUT: 04:12:36 INFO - 2016-01-25 04:12:36,343 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:12:36 INFO - 2016-01-25 04:12:36,343 DEBUG : BROWSER_OUTPUT: Number of tests: 14 04:12:36 INFO - 2016-01-25 04:12:36,343 DEBUG : BROWSER_OUTPUT: 04:12:36 INFO - 2016-01-25 04:12:36,343 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.10 Median:109.00 stddev:3.21 (2.9%) stddev-sans-first:3.33 04:12:36 INFO - 2016-01-25 04:12:36,343 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 103.0 108.0 109.0 109.0 100.0 108.0 106.0 109.0 04:12:36 INFO - 2016-01-25 04:12:36,343 DEBUG : BROWSER_OUTPUT: 04:12:36 INFO - 2016-01-25 04:12:36,343 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:143.30 Median:149.00 stddev:16.64 (11.2%) stddev-sans-first:17.28 04:12:36 INFO - 2016-01-25 04:12:36,343 DEBUG : BROWSER_OUTPUT: Values: 153.0 120.0 142.0 164.0 131.0 158.0 145.0 125.0 166.0 129.0 04:12:36 INFO - 2016-01-25 04:12:36,343 DEBUG : BROWSER_OUTPUT: 04:12:36 INFO - 2016-01-25 04:12:36,343 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:159.40 Median:160.00 stddev:1.43 (0.9%) stddev-sans-first:1.50 04:12:36 INFO - 2016-01-25 04:12:36,344 DEBUG : BROWSER_OUTPUT: Values: 160.0 160.0 159.0 160.0 157.0 160.0 158.0 162.0 160.0 158.0 04:12:36 INFO - 2016-01-25 04:12:36,344 DEBUG : BROWSER_OUTPUT: 04:12:36 INFO - 2016-01-25 04:12:36,344 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:85.90 Median:71.00 stddev:31.86 (44.9%) stddev-sans-first:33.33 04:12:36 INFO - 2016-01-25 04:12:36,344 DEBUG : BROWSER_OUTPUT: Values: 71.0 70.0 71.0 139.0 70.0 72.0 72.0 70.0 153.0 71.0 04:12:36 INFO - 2016-01-25 04:12:36,344 DEBUG : BROWSER_OUTPUT: 04:12:36 INFO - 2016-01-25 04:12:36,344 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:102.80 Median:89.00 stddev:22.42 (25.2%) stddev-sans-first:23.13 04:12:36 INFO - 2016-01-25 04:12:36,344 DEBUG : BROWSER_OUTPUT: Values: 88.0 87.0 129.0 89.0 90.0 90.0 135.0 89.0 90.0 141.0 04:12:36 INFO - 2016-01-25 04:12:36,344 DEBUG : BROWSER_OUTPUT: 04:12:36 INFO - 2016-01-25 04:12:36,344 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.10 Median:110.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 04:12:36 INFO - 2016-01-25 04:12:36,344 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 111.0 110.0 110.0 111.0 110.0 110.0 109.0 04:12:36 INFO - 2016-01-25 04:12:36,344 DEBUG : BROWSER_OUTPUT: 04:12:36 INFO - 2016-01-25 04:12:36,344 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.99 (0.7%) stddev-sans-first:0.71 04:12:36 INFO - 2016-01-25 04:12:36,344 DEBUG : BROWSER_OUTPUT: Values: 148.0 145.0 146.0 145.0 146.0 146.0 147.0 145.0 146.0 145.0 04:12:36 INFO - 2016-01-25 04:12:36,344 DEBUG : BROWSER_OUTPUT: 04:12:36 INFO - 2016-01-25 04:12:36,344 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 04:12:36 INFO - 2016-01-25 04:12:36,344 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 96.0 95.0 95.0 95.0 95.0 96.0 96.0 97.0 04:12:36 INFO - 2016-01-25 04:12:36,345 DEBUG : BROWSER_OUTPUT: 04:12:36 INFO - 2016-01-25 04:12:36,345 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:55.40 Median:56.00 stddev:1.07 (1.9%) stddev-sans-first:1.13 04:12:36 INFO - 2016-01-25 04:12:36,345 DEBUG : BROWSER_OUTPUT: Values: 55.0 56.0 55.0 55.0 56.0 55.0 56.0 57.0 56.0 53.0 04:12:36 INFO - 2016-01-25 04:12:36,345 DEBUG : BROWSER_OUTPUT: 04:12:36 INFO - 2016-01-25 04:12:36,345 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:62.70 Median:63.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 04:12:36 INFO - 2016-01-25 04:12:36,345 DEBUG : BROWSER_OUTPUT: Values: 63.0 63.0 63.0 63.0 63.0 62.0 62.0 63.0 62.0 63.0 04:12:36 INFO - 2016-01-25 04:12:36,345 DEBUG : BROWSER_OUTPUT: 04:12:36 INFO - 2016-01-25 04:12:36,345 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:77.00 Median:77.00 stddev:0.94 (1.2%) stddev-sans-first:1.00 04:12:36 INFO - 2016-01-25 04:12:36,345 DEBUG : BROWSER_OUTPUT: Values: 77.0 76.0 78.0 77.0 79.0 77.0 77.0 76.0 77.0 76.0 04:12:36 INFO - 2016-01-25 04:12:36,345 DEBUG : BROWSER_OUTPUT: 04:12:36 INFO - 2016-01-25 04:12:36,345 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:115.00 Median:116.50 stddev:6.24 (5.4%) stddev-sans-first:5.90 04:12:36 INFO - 2016-01-25 04:12:36,345 DEBUG : BROWSER_OUTPUT: Values: 123.0 106.0 115.0 118.0 118.0 109.0 114.0 114.0 108.0 125.0 04:12:36 INFO - 2016-01-25 04:12:36,345 DEBUG : BROWSER_OUTPUT: 04:12:36 INFO - 2016-01-25 04:12:36,345 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:134.40 Median:136.00 stddev:4.97 (3.7%) stddev-sans-first:5.18 04:12:36 INFO - 2016-01-25 04:12:36,345 DEBUG : BROWSER_OUTPUT: Values: 137.0 142.0 125.0 135.0 135.0 135.0 127.0 137.0 137.0 134.0 04:12:36 INFO - 2016-01-25 04:12:36,346 DEBUG : BROWSER_OUTPUT: 04:12:36 INFO - 2016-01-25 04:12:36,346 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.10 Median:62.00 stddev:1.45 (2.3%) stddev-sans-first:1.48 04:12:36 INFO - 2016-01-25 04:12:36,346 DEBUG : BROWSER_OUTPUT: Values: 61.0 64.0 64.0 61.0 62.0 62.0 62.0 61.0 64.0 60.0 04:12:36 INFO - 2016-01-25 04:12:36,346 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:12:36 INFO - 2016-01-25 04:12:36,346 DEBUG : BROWSER_OUTPUT: 04:12:36 INFO - 2016-01-25 04:12:36,990 INFO : Browser exited with error code: 0 04:12:37 INFO - 2016-01-25 04:12:37,037 INFO : Completed test kraken (00:00:56) 04:12:37 INFO - 2016-01-25 04:12:37,038 INFO : Starting test v8_7 04:12:37 INFO - 2016-01-25 04:12:37,038 DEBUG : operating with platform_type : linux_ 04:12:37 INFO - 2016-01-25 04:12:37,038 INFO : Initialising browser for v8_7 test... 04:12:37 INFO - 2016-01-25 04:12:37,044 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpO8H8iV/profile http://localhost:60306/getInfo.html 04:12:40 INFO - 2016-01-25 04:12:40,152 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:12:40 INFO - 2016-01-25 04:12:40,152 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:12:40 INFO - 2016-01-25 04:12:40,152 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:12:40 INFO - 2016-01-25 04:12:40,152 DEBUG : BROWSER_OUTPUT: __metrics 04:12:40 INFO - 2016-01-25 04:12:40,281 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] 04:12:41 INFO - 2016-01-25 04:12:41,285 INFO : Browser initialized. 04:12:41 INFO - 2016-01-25 04:12:41,286 INFO : Running cycle 1/1 for v8_7 test... 04:12:41 INFO - 2016-01-25 04:12:41,286 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpO8H8iV/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:12:52 INFO - 2016-01-25 04:12:52,825 DEBUG : BROWSER_OUTPUT: RSS: Main: 129044480 04:12:52 INFO - 2016-01-25 04:12:52,825 DEBUG : BROWSER_OUTPUT: 04:13:14 INFO - 2016-01-25 04:13:14,239 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60306/tests/v8_7/run.html (next: http://localhost:60306/tests/v8_7/run.html) 04:13:14 INFO - 2016-01-25 04:13:14,489 DEBUG : BROWSER_OUTPUT: RSS: Main: 424820736 04:13:14 INFO - 2016-01-25 04:13:14,490 DEBUG : BROWSER_OUTPUT: 04:13:14 INFO - 2016-01-25 04:13:14,490 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:13:14 INFO - 2016-01-25 04:13:14,490 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:13:14 INFO - 2016-01-25 04:13:14,490 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:13:14 INFO - 2016-01-25 04:13:14,490 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:13:14 INFO - 2016-01-25 04:13:14,490 DEBUG : BROWSER_OUTPUT: |0;Richards;166.5278934221482 04:13:14 INFO - 2016-01-25 04:13:14,491 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;170.2127659574468 04:13:14 INFO - 2016-01-25 04:13:14,491 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.4076557697681 04:13:14 INFO - 2016-01-25 04:13:14,491 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5005 04:13:14 INFO - 2016-01-25 04:13:14,491 DEBUG : BROWSER_OUTPUT: |4;RayTrace;939.8496240601504 04:13:14 INFO - 2016-01-25 04:13:14,491 DEBUG : BROWSER_OUTPUT: |5;Earley;553.7098560354374 04:13:14 INFO - 2016-01-25 04:13:14,492 DEBUG : BROWSER_OUTPUT: |6;Boyer;10806.451612903225 04:13:14 INFO - 2016-01-25 04:13:14,492 DEBUG : BROWSER_OUTPUT: |7;RegExp;23227.272727272728 04:13:14 INFO - 2016-01-25 04:13:14,492 DEBUG : BROWSER_OUTPUT: |8;Splay;544.3658138268917 04:13:14 INFO - 2016-01-25 04:13:14,492 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4822.115384615385 04:13:14 INFO - 2016-01-25 04:13:14,492 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:13:14 INFO - 2016-01-25 04:13:14,492 DEBUG : BROWSER_OUTPUT: __startTimestamp1453723994487__endTimestamp 04:13:14 INFO - 2016-01-25 04:13:14,493 DEBUG : BROWSER_OUTPUT: 04:13:14 INFO - 2016-01-25 04:13:14,493 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:13:14 INFO - 2016-01-25 04:13:14,493 DEBUG : BROWSER_OUTPUT: Number of tests: 10 04:13:14 INFO - 2016-01-25 04:13:14,493 DEBUG : BROWSER_OUTPUT: 04:13:14 INFO - 2016-01-25 04:13:14,494 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.53 Median:166.53 stddev:0.00 (0.0%) 04:13:14 INFO - 2016-01-25 04:13:14,494 DEBUG : BROWSER_OUTPUT: Values: 166.5 04:13:14 INFO - 2016-01-25 04:13:14,494 DEBUG : BROWSER_OUTPUT: 04:13:14 INFO - 2016-01-25 04:13:14,494 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:170.21 Median:170.21 stddev:0.00 (0.0%) 04:13:14 INFO - 2016-01-25 04:13:14,494 DEBUG : BROWSER_OUTPUT: Values: 170.2 04:13:14 INFO - 2016-01-25 04:13:14,494 DEBUG : BROWSER_OUTPUT: 04:13:14 INFO - 2016-01-25 04:13:14,494 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.41 Median:279.41 stddev:0.00 (0.0%) 04:13:14 INFO - 2016-01-25 04:13:14,495 DEBUG : BROWSER_OUTPUT: Values: 279.4 04:13:14 INFO - 2016-01-25 04:13:14,495 DEBUG : BROWSER_OUTPUT: 04:13:14 INFO - 2016-01-25 04:13:14,495 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5005.00 Median:5005.00 stddev:0.00 (0.0%) 04:13:14 INFO - 2016-01-25 04:13:14,495 DEBUG : BROWSER_OUTPUT: Values: 5005.0 04:13:14 INFO - 2016-01-25 04:13:14,495 DEBUG : BROWSER_OUTPUT: 04:13:14 INFO - 2016-01-25 04:13:14,495 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:939.85 Median:939.85 stddev:0.00 (0.0%) 04:13:14 INFO - 2016-01-25 04:13:14,495 DEBUG : BROWSER_OUTPUT: Values: 939.8 04:13:14 INFO - 2016-01-25 04:13:14,496 DEBUG : BROWSER_OUTPUT: 04:13:14 INFO - 2016-01-25 04:13:14,496 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:553.71 Median:553.71 stddev:0.00 (0.0%) 04:13:14 INFO - 2016-01-25 04:13:14,496 DEBUG : BROWSER_OUTPUT: Values: 553.7 04:13:14 INFO - 2016-01-25 04:13:14,496 DEBUG : BROWSER_OUTPUT: 04:13:14 INFO - 2016-01-25 04:13:14,496 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10806.45 Median:10806.45 stddev:0.00 (0.0%) 04:13:14 INFO - 2016-01-25 04:13:14,496 DEBUG : BROWSER_OUTPUT: Values: 10806.5 04:13:14 INFO - 2016-01-25 04:13:14,496 DEBUG : BROWSER_OUTPUT: 04:13:14 INFO - 2016-01-25 04:13:14,497 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:23227.27 Median:23227.27 stddev:0.00 (0.0%) 04:13:14 INFO - 2016-01-25 04:13:14,497 DEBUG : BROWSER_OUTPUT: Values: 23227.3 04:13:14 INFO - 2016-01-25 04:13:14,497 DEBUG : BROWSER_OUTPUT: 04:13:14 INFO - 2016-01-25 04:13:14,497 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:544.37 Median:544.37 stddev:0.00 (0.0%) 04:13:14 INFO - 2016-01-25 04:13:14,497 DEBUG : BROWSER_OUTPUT: Values: 544.4 04:13:14 INFO - 2016-01-25 04:13:14,497 DEBUG : BROWSER_OUTPUT: 04:13:14 INFO - 2016-01-25 04:13:14,497 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 04:13:14 INFO - 2016-01-25 04:13:14,497 DEBUG : BROWSER_OUTPUT: Values: 4822.1 04:13:14 INFO - 2016-01-25 04:13:14,497 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:13:14 INFO - 2016-01-25 04:13:14,497 DEBUG : BROWSER_OUTPUT: 04:13:15 INFO - 2016-01-25 04:13:15,174 INFO : Browser exited with error code: 0 04:13:15 INFO - 2016-01-25 04:13:15,188 INFO : Completed test v8_7 (00:00:38) 04:13:15 INFO - 2016-01-25 04:13:15,473 INFO : Completed test suite (00:20:03) 04:13:15 INFO - 2016-01-25 04:13:15,474 DEBUG : Working with test: dromaeo_css 04:13:15 INFO - 2016-01-25 04:13:15,474 DEBUG : Generating results file: dromaeo_css 04:13:15 INFO - 2016-01-25 04:13:15,475 DEBUG : Working with test: kraken 04:13:15 INFO - 2016-01-25 04:13:15,475 DEBUG : Generating results file: kraken 04:13:15 INFO - 2016-01-25 04:13:15,475 INFO : javascript benchmark 04:13:15 INFO - 2016-01-25 04:13:15,475 DEBUG : Working with test: v8_7 04:13:15 INFO - 2016-01-25 04:13:15,475 DEBUG : Generating results file: v8_7 04:13:15 INFO - 2016-01-25 04:13:15,476 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:13:15 INFO - 2016-01-25 04:13:15,531 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,53,35]] 04:13:15 INFO - 2016-01-25 04:13:15,531 DEBUG : process_Request line: dromaeo_css 7238.84 graph.html#tests=[[72,53,35]] 04:13:15 INFO - 2016-01-25 04:13:15,531 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:13:15 INFO - 2016-01-25 04:13:15,567 DEBUG : process_Request line: kraken 1456.70 graph.html#tests=[[232,53,35]] 04:13:15 INFO - 2016-01-25 04:13:15,567 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:13:15 INFO - 2016-01-25 04:13:15,597 DEBUG : process_Request line: v8_7 23228.52 graph.html#tests=[[230,53,35]] 04:13:15 INFO - 2016-01-25 04:13:15,599 INFO : javascript benchmark 04:13:15 INFO - 2016-01-25 04:13:15,602 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3305.3058857639894, 3394.372041172385, 3416.5387672664183, 3422.418188907887, 3429.537012503312, 5631.352394474631, 5677.914831277524, 5697.857553561163, 5704.572157088214, 5706.51494622957, 5660.22656889973, 5719.056355701315, 5721.370649228582, 5723.9713801431035, 5734.627249228797, 4953.331300274453, 5161.0, 5202.167653175493, 5262.684238945675, 5298.496642818926, 4998.825041123561, 5054.823081192159, 5132.999065182291, 5154.381474223099, 5161.793528258884, 5141.665791723544, 5146.408163061258, 5148.047611191922, 5152.149895267276, 5181.4300426953005, 4992.850214493571, 5139.280500729901, 5147.7683504242395, 5208.479152084799, 5213.556847667953, 5003.249512573107, 5077.746112694351, 5125.538701516882, 5141.948580514222, 5142.820001299937, 5456.48163424474, 5460.262864513319, 5472.015037293286, 5477.561795056426, 5492.203630473599, 5848.298204215522, 5916.526677865803, 6080.908786368208, 6085.847853803646, 6086.7565297388055, 6049.395060493959, 6119.5410344224365, 6121.724522396503, 6152.87694246117, 6155.107509411155, 5745.009209936783, 5777.768889244425, 5778.27771528559, 5783.768649254025, 5816.854578635525, 5933.970330148321, 6022.608530445507, 6057.3639767824625, 6231.594946328474, 6261.342559031327, 5964.403559644001, 5966.522678185735, 5967.492763115097, 5970.522358211333, 5982.880342393215, 6041.24484439445, 6058.636481811017, 6060.787872424444, 6062.939370606326, 6065.120557519135, 5785.1611516329895, 5885.0, 5972.552058595623, 5989.431004054608, 6121.326654068049, 6024.3975602439405, 6034.879302413927, 6040.7583696651645, 6044.455998960115, 6047.546434017467, 4627.95870929045, 4631.814727410866, 4633.72197668141, 4639.0, 4660.883477913011, 4054.7769872657286, 4062.370332598452, 4129.8967525811495, 4130.967258185454, 4136.751794892316, 5675.943240567624, 5698.31620205578, 5706.029974904276, 5708.029634962067, 5716.5426765859465, 5848.619839710405, 6074.240719910012, 6076.605020673642, 6079.787207447718, 6081.513478921675, 5549.861253468695, 5612.130119831432, 5632.267805185382, 5650.067738823131, 5676.4323567642905, 5281.181416880389, 5339.652922560022, 5342.91985620216, 5343.465653434703, 5345.9465405345445, 6024.3072046714315, 6149.600275982047, 6314.052892066226, 6346.27017892939, 6356.427921486996, 6005.39946005396, 6126.417990290915, 6127.448529632355, 6129.509639228941, 6130.390533016695, 6157.96921015392, 6206.782762603287, 6209.658468784261, 6212.285587157535, 6220.533459990428, 5898.498627616529, 5904.9704751475965, 5972.193753843176, 5982.760689572368, 6015.157877897011, 6067.332593414809, 6069.51443884497, 6071.666058366655, 6079.331273559993, 6098.908516372347, 5910.024845900378, 5913.497352725067, 5914.970425148019, 5921.5854890159, 5921.822345329475, 5791.160281759037, 5818.418158184317, 5883.2057672213705, 5904.763809447574, 5917.644941303535, 5852.795152169653, 5878.823635290948, 5880.735366908414, 5880.970595146997, 5887.61730487517, 5882.735276912464, 5950.137230101697, 5952.732127054206, 5959.851003724942, 5980.850478737892, 5644.096944488862, 5716.399778023248, 5735.827925162252, 5774.04728219839, 5813.738381772746], "unit": "ms", "name": "dojo.html", "value": 5574.683188769528}, {"lowerIsBetter": false, "replicates": [597.5458651424918, 633.4710516718541, 640.80135158101, 643.1028714942652, 644.8839208942392, 36383.63616363836, 42338.57661423388, 42492.78753606228, 42642.36036459452, 42675.35986960198, 45646.54353456473, 46170.307445388346, 46189.0, 46199.76900115503, 46245.0, 8454.070052294273, 8526.658933642648, 9191.63233470662, 9397.718068457923, 10887.183461240398, 11099.445027748621, 11109.55561777532, 11204.383758893258, 11220.438978051106, 11230.719232019224, 11193.776124477505, 11286.774264514705, 11334.433278336091, 11345.37600431976, 11351.602693905716, 11066.336019838795, 11180.776384472305, 11186.720331991684, 11200.327980321206, 11205.271657342328, 10853.837192442119, 10957.397343146124, 10983.780324393467, 10984.231103822736, 10986.615468458565, 46386.76806615979, 46834.765826170995, 46983.0, 46992.7650361746, 47031.29453058207, 3663.8900832974787, 3681.4845921571, 3789.905252368685, 3841.692664586826, 4241.34259189826, 34468.6553134468, 34491.65508344909, 34908.30183396318, 34985.82507087474, 35271.0, 3512.2273099918234, 3552.928941421157, 3590.622984586633, 3698.537682789651, 3705.962940370589, 331053.0, 334307.0, 334478.32760836283, 335690.0, 335754.0, 67854.3214567858, 68348.31651683518, 69389.0, 78304.43391132145, 78686.6065669668, 73121.0, 73343.63328183324, 73516.63241683757, 73625.63187184137, 73773.0, 18229.817701823078, 18600.906995464935, 18627.534311642317, 18642.720359194624, 18678.906605467157, 13818.930905345409, 14033.438662453387, 14069.507567235303, 14073.788893166611, 14119.64700882486, 22857.771422285896, 23044.193453229058, 23159.189428370264, 23202.0, 23213.187538436072, 8171.142030086874, 8276.08963014068, 8342.332613390914, 8422.477861128657, 8425.199606037417, 1035.4098164046572, 1036.3108532825738, 1120.5405783628673, 1160.6692092753524, 1231.1259006105586, 31566.0, 32145.0, 32199.195020124214, 32812.343753124806, 32935.67064329374, 1097.3635291530893, 1102.3826657071904, 1137.562038615139, 1184.5498710489958, 1304.1457845111468, 14684.559463216121, 16508.0, 16735.581610459834, 17006.659866802842, 17272.22274997628, 405902.0, 412675.0, 413662.0, 414270.0, 416715.0, 61889.690551546955, 62171.0, 62264.37735622586, 62309.0, 62349.68825155845, 1500.5498350494809, 1502.2563830903773, 1504.9021813582083, 1507.9924600376928, 1535.3398038843404, 32706.509402358508, 33300.333993320484, 33306.500402494465, 33501.32997339991, 33918.491222631186, 55102.173467398825, 55447.16829247484, 55498.72250638721, 55541.7222913899, 55580.72209638926, 377230.0, 379255.0, 379723.0, 380456.0, 380804.0, 31736.841315793274, 32392.190195245308, 35645.82177089098, 36394.11157282489, 37363.813180933925, 48485.75757121192, 48570.271445929044, 48811.755941220064, 49575.752121240606, 50349.24476132788, 40443.0, 40558.0, 41104.58895411127, 41669.0, 44943.77528112339, 40675.389869152576, 42162.78918605387, 42181.0, 42303.36544951767, 42990.0, 39434.605653943094, 41233.793831030656, 41942.0, 42118.789406052776, 42537.574624253364, 33093.503597445575, 33495.83252083724, 35147.29705405929, 36282.0, 37157.44263836099, 27837.304067398476, 29727.25681857971, 30100.0, 30487.542686860157, 30557.694423056375], "unit": "ms", "name": "ext.html", "value": 21448.64904340375}, {"lowerIsBetter": false, "replicates": [386.76407391491193, 389.0526567807391, 390.18646122833906, 391.4304686680879, 393.60442755031187, 12582.307973061477, 14998.700025999473, 17628.823711762878, 19324.420267391964, 19332.806671933293, 18991.905040474812, 19091.14089865956, 19233.807661923376, 19396.22415103394, 19757.604847903032, 5649.717514124298, 5796.217510636052, 5801.07182850744, 5806.448387403211, 5819.709014549277, 4452.888677783065, 4614.353990441341, 5761.279840019997, 6290.779822706206, 6478.54650174488, 6125.448709616134, 6346.238451385841, 6385.553011289212, 6408.711607977652, 6431.871362572746, 6480.708368123445, 6489.22129344477, 6500.252470965852, 6529.249136349333, 6530.902036469409, 4395.055063161436, 4475.2168370535355, 5816.941830581683, 5838.591298609099, 5844.064949608042, 14754.704905901823, 14773.556793296219, 14776.0, 15070.849291507055, 15316.540503784905, 2025.8075482829108, 2052.8049835265624, 2058.279602139254, 2071.388940262626, 2082.552251265985, 10521.526531306034, 10521.78956420875, 10630.521626526825, 10768.838467422995, 10816.188785841094, 1646.1275523972313, 1647.901125932436, 1675.0452242221938, 1694.3815507339855, 1763.2418060234095, 65382.3461765381, 68206.0, 68842.0, 70183.29816701819, 70256.64871675608, 7616.428767842434, 7689.0, 7965.243301886311, 8032.879506807402, 8054.670979288352, 9674.274429417821, 9697.5151242439, 9699.0, 9705.466199358962, 9716.95141524302, 6487.0269459580495, 6533.705983230766, 6570.737170513222, 6573.276939536647, 6585.176852893388, 6887.345702158287, 6895.482838787111, 6915.792526224222, 6931.0, 6959.930400695928, 3687.94468082979, 3736.8878933632036, 3741.0834345584963, 3765.021094515391, 3765.5293088363956, 1259.817326487654, 1270.3965616332353, 1272.1730874931184, 1285.7685616589104, 1311.895048396126, 499.153934081728, 528.2261486921678, 535.3736128729396, 540.7161240348848, 544.2543715110324, 11293.15301352402, 12956.222626642431, 13470.326483675777, 13512.59462216135, 13633.659158520917, 523.9834720642018, 533.8398480455847, 536.0404875273296, 547.1437200780765, 559.3623269472804, 6803.625800580917, 6885.277045910208, 7075.787726368218, 7105.82235444118, 7124.358807707331, 679655.0, 682923.0, 695259.0, 698210.0, 726310.0, 47020.529794701615, 47164.5283547167, 65988.01017984735, 79205.0, 87008.5649571748, 511.75435790820615, 525.3433208489388, 528.2762615217177, 528.5877015927582, 530.0882482130729, 10721.30311529748, 11047.72380690489, 11053.226274160732, 11192.272502287326, 11245.32528048287, 39193.0, 39706.40440393454, 40436.0, 40518.987025324604, 41483.37774933439, 53009.20486192787, 53773.731131344095, 53796.46203537915, 54018.729906351786, 54416.72791636016, 9133.817323653622, 9242.12199841014, 9370.578323975575, 9447.527623618655, 9664.178544823768, 11554.306741595532, 13340.533081342495, 13762.65593360174, 13853.861461385257, 13879.375428105557, 11939.76120477603, 11989.160758746804, 12041.819372709591, 12066.276023438622, 12201.755964880474, 11670.241434306743, 11916.404179791149, 11960.46177922013, 11997.820032699341, 12043.09676774228, 11849.229800062969, 11927.582534611247, 12054.397280136134, 12208.694782630506, 12292.262464252173, 9319.254459643076, 9328.673496427593, 9342.065793420876, 9410.43537387759, 9420.481873497023, 11444.599439019594, 11932.105092117952, 12392.31842248685, 12684.87315126874, 12787.168834025759], "unit": "ms", "name": "jquery.html", "value": 7896.410966318605}, {"lowerIsBetter": false, "replicates": [1597.6005998500375, 1599.4561848971355, 1848.3900312896747, 1859.7117446795746, 1895.1282410091362, 7491.438142139334, 7630.732924347649, 7964.681412743491, 8129.30900873425, 8130.065042520112, 7924.881126783102, 8090.069641991173, 8144.91855081449, 8154.91845081549, 8167.18328167183, 2386.331827088414, 2417.540667273221, 2419.11702228687, 2420.9515809683794, 2421.4188594737225, 2161.167950339115, 2196.4728465168323, 2361.822863285252, 2436.671049408325, 2441.206607852455, 2333.684952531412, 2345.64815277708, 2349.0368948731025, 2360.3509035015422, 2361.445060410802, 2440.694913135858, 2453.251758213762, 2459.717132529764, 2462.507498500298, 2465.8520488770732, 2403.3631087761755, 2460.778529932297, 2461.4953934443397, 2462.7660372264604, 2463.692038495188, 8379.581020948988, 8453.365997550147, 8463.788405289917, 8466.32269418445, 8487.872681909776, 5066.341375621182, 5130.179171332569, 5141.897162056775, 5147.922781158286, 5148.742562871841, 3243.172990887332, 3288.2108294009504, 3333.7166340861054, 3355.1612096975755, 3362.277110421271, 1081.5944020992129, 1096.9396683182422, 1111.522045520426, 1118.7538741476862, 1122.966311010671, 11469.025132863717, 11486.081113510983, 11491.65525034242, 11611.535538578446, 11681.532738690443, 4599.310103484504, 4603.572892403366, 4654.720716757005, 4661.836835710734, 4665.626749860003, 9870.407775533491, 9884.950575247078, 9900.405975641484, 9905.80188396228, 9918.752031199134, 5138.743062846843, 5157.355330583677, 5170.1986192140275, 5174.456682048406, 5174.534291913746, 4669.696469729524, 4702.0, 4707.717536947725, 4729.6689231754135, 4754.738489383048, 3468.0462872709704, 4013.7792421417103, 4022.7586344819406, 4023.195360927826, 4034.3545032794614, 1218.8049912014035, 1270.7458508298378, 1272.993635031819, 1285.13895689888, 1293.4567481657725, 1197.988020119805, 1364.7134101838726, 1405.3184205660248, 1425.8075159853288, 1443.8449240607472, 7789.7273595423885, 7826.530408175528, 7829.569373684502, 7842.764717058498, 7883.093444253869, 1200.7478429529897, 1218.713602303458, 1220.0422668205417, 1220.9328486933127, 1226.7730469862925, 6267.310595834455, 6331.810045698637, 6388.904166437507, 6420.165378500765, 6433.935660643428, 9824.410535367759, 10114.393136411838, 10127.898721012843, 10130.848037279447, 10135.442550659785, 9839.55721992512, 9997.100260976547, 10009.649662261785, 10018.3488073275, 10055.39667619945, 7856.646450909723, 7859.764207073797, 7911.485753426009, 7918.168592297841, 7927.167647397056, 7512.849743005218, 7528.284812942762, 7555.848883022419, 7584.848303033798, 7606.087269527692, 8658.826823463369, 8861.822763544564, 8880.73357799267, 8891.0, 8975.32685048637, 8948.642054317754, 8974.955125224593, 9021.323400745101, 9030.503322317336, 9246.815063698554, 7492.0, 7525.849483010418, 7580.507267027626, 7587.772366829004, 7589.468737188344, 7250.383717384081, 7406.8148296290865, 8058.959705201437, 8093.988251468566, 8118.959405202936, 7354.521956072838, 7390.187079421152, 7423.591702456417, 7502.512336698097, 7524.924750752422, 7331.193568707331, 7382.224866388952, 7385.0, 7432.145303290191, 7495.850082998419, 7391.1869694334655, 7419.740309089156, 7462.850742985219, 7464.328210461084, 7474.177840437656, 6887.965560172367, 6935.306469353024, 6935.895961560682, 6940.340667636567, 6949.0, 6791.0, 6843.178818541807, 6857.108575885103, 6868.62222577763, 6873.518853680194], "unit": "ms", "name": "mootools.html", "value": 4828.118473377448}, {"lowerIsBetter": false, "replicates": [355.19371027766965, 357.7603005985989, 366.7286208205925, 370.7367768884092, 375.3974870333115, 5890.705464726757, 5955.344912059675, 5965.791197308095, 5998.490128339096, 6022.939770602293, 5776.249087618614, 5869.589128760988, 5873.11903214518, 5873.735681894314, 5917.408259174081, 4625.745583992879, 4627.259638457847, 4637.466691330506, 4639.095376401595, 4644.86065418038, 4460.687751857371, 4527.750973696446, 4581.885452863672, 4645.396098507206, 4656.883577910562, 4591.885202869921, 4597.42532183477, 4600.033992861487, 4604.953950460503, 4619.676622636417, 4596.954030459686, 4600.286955521883, 4604.493505714386, 4607.838725644587, 4612.0545288215835, 4107.609777071173, 4110.876673699794, 4111.71218014739, 4117.485314335708, 4118.908489250351, 5546.889062218774, 5603.299587551556, 5625.071863142576, 5681.403452637455, 5682.886342273131, 5405.27028851104, 5409.594280428983, 5409.702466364349, 5412.107002344648, 5417.024935511607, 6039.1545183674325, 6317.4946004319545, 6324.083007963865, 6324.430801227865, 6327.778527751552, 4428.844990425319, 4463.68754187207, 4539.296409056601, 4542.4776150742755, 4543.409356783597, 6410.0, 6413.518986076063, 6425.646589437579, 6431.09964604951, 6431.389018043325, 4631.884202894955, 4636.095961287517, 4636.397268355092, 4640.466346370211, 4642.0715856828765, 4632.490426053131, 4708.034852855157, 4712.387389639325, 4746.833860814855, 4786.44955830084, 5405.297311349499, 5406.702631355313, 5412.621116521806, 5414.7834086636885, 5421.213923981, 6353.777617783356, 6357.014662727192, 6357.300696923335, 6359.300476947532, 6359.491240700733, 1684.082175214511, 1727.3608764756868, 1727.9481615551554, 1731.8527925126252, 1732.7400889866622, 1168.1764356128908, 1174.565410797993, 1175.1421462332546, 1180.055955235808, 1208.2931485081326, 6136.693165341715, 6136.815895523141, 6140.907886381708, 6145.723442445012, 6152.692365381713, 6545.967270163619, 6546.869062618721, 6547.9017814732815, 6550.050242714875, 6555.639439830855, 6001.879962400815, 6131.540134489931, 6140.692965351804, 6142.140100385949, 6147.385261473906, 3589.407747721649, 3610.223801882608, 3611.638836116367, 3614.87347942826, 3618.4210526316187, 6691.197056353171, 6694.631795251308, 6701.028350889093, 6702.061711360413, 6702.664866756642, 6609.20689517261, 6697.196336439659, 6700.664966751643, 6708.631025293558, 6712.093867327946, 6679.632620205838, 6680.966595166993, 6685.331466853373, 6694.866102678016, 6698.229703584053, 6321.431071203614, 6404.295527491879, 6521.34786521363, 6525.608463492205, 6533.248676402274, 6344.270408903035, 6411.5832470889245, 6437.935620643733, 6438.742450301936, 6453.677316134081, 6639.203295604559, 6641.402273795382, 6647.202335719745, 6654.534182607171, 6658.6337751424135, 4599.942013337019, 4627.537246275346, 4662.580367766917, 4663.930041049455, 4730.739809310521, 6601.966990165019, 6604.075429439787, 6606.669666516559, 6611.173603299588, 6617.636030018395, 6337.7781777637565, 6409.102725618511, 6409.35906409374, 6418.19772528434, 6419.807405777834, 6264.279607844974, 6335.0, 6412.871742565216, 6414.839629009125, 6421.550491465552, 6312.652804095819, 6316.778912738032, 6317.241930968313, 6327.873442531031, 6329.272133704683, 6384.6169229846355, 6404.071409645482, 6429.646369449725, 6455.903161452676, 6461.64460954652, 6173.259208894781, 6260.718267678057, 6266.310705822265, 6300.495960323255, 6308.589941653778], "unit": "ms", "name": "prototype.html", "value": 4844.685584423709}, {"lowerIsBetter": false, "replicates": [927.2813569483653, 939.0656296984502, 943.6602822983725, 946.460517505022, 952.8046750416163, 13083.607491775238, 13372.264525451097, 13388.53140140093, 13393.665158371034, 13398.799018014726, 14241.0, 14341.713165736679, 14361.28193590319, 14367.0, 14375.424983000667, 767.2059418501851, 771.2788542712553, 916.9908300916973, 929.6281487405024, 933.0389698610442, 911.6399022386187, 912.3750231091724, 912.434290739739, 918.5407296351824, 918.5958178401515, 813.5525460996458, 962.37445660321, 969.6557722008691, 969.6557722008691, 970.2480577552383, 808.59974312715, 946.5693109635134, 954.0316578672653, 960.6397600899662, 963.7686955130788, 718.1884470548247, 718.8167017410527, 719.3993015831787, 719.7480881691419, 720.103471178381, 14217.146971181763, 14343.139411635335, 14381.28093595316, 14382.928085359506, 14384.64038399038, 12736.872631273662, 12842.743145137138, 12909.806352904714, 12951.48194072236, 12986.805197922038, 10002.59989600415, 10039.69880903574, 10069.89930100697, 10127.797444051077, 10166.542505587193, 3330.7501937354555, 3386.356592247465, 3389.4915762635555, 3392.5759280089987, 3395.6434574369828, 53191.734041329546, 53380.19929701058, 53420.0, 56767.14849277264, 56993.14510282307, 9622.51887405627, 9656.903430965742, 9663.082007209305, 9683.0, 9712.22302215821, 20982.0, 21048.894755526126, 21222.681659775117, 21370.0, 21382.144714211256, 7449.925500745032, 7565.773026809205, 7571.46999710026, 7595.5442673439775, 7632.542047477169, 4091.488563929509, 4111.465509483748, 4144.958550414457, 4145.585441455831, 4173.31140361843, 3375.1393394684687, 3416.128887133765, 3419.2990436960363, 3426.434638284655, 3429.3655673700446, 473.9123262196505, 495.1631742355408, 496.4638190753977, 555.6166245290736, 570.3469527391114, 538.2330179494205, 559.8180591307841, 608.656109298245, 633.6261605652595, 642.9549931504844, 7092.503524753218, 7215.60314182725, 7272.527285726411, 7307.212229410913, 7500.737474188377, 565.6775637886448, 611.248164757351, 615.4737699267151, 617.4998251416367, 633.7781776378231, 3977.980110099431, 3980.661643760313, 4019.9196016079513, 4105.692073094529, 4109.0959988802415, 62220.0, 70160.0, 70511.0, 70755.64622176856, 70889.64555177192, 54370.0, 55486.72256638691, 55487.16769248465, 56092.719536402874, 56337.0, 50706.23940640893, 50935.0, 51453.48546514487, 51869.7406512965, 52649.2102618461, 8242.340612750846, 8260.256576908107, 8353.164683531599, 8485.490870547786, 8560.143985601639, 38086.0, 39167.0, 39205.2158956825, 41082.17835643211, 41203.38194927138, 52247.21629175489, 52342.21486677627, 52849.0, 52980.20529692135, 53032.73483632557, 8439.746807595782, 8666.263367613823, 8738.475691458532, 8740.431871928304, 8761.342899282452, 12202.938985305016, 12306.07704422154, 12375.0, 12556.87443125557, 12716.618501444971, 10472.214583906085, 10614.681559553226, 10734.677959661223, 10777.676669699922, 10885.727856803644, 11533.0, 11858.525658973544, 11926.224795388272, 11968.46141923598, 12455.688607784516, 10771.569137234736, 11110.000099991039, 11239.269447485887, 11728.0, 11851.170418070997, 10214.642487512901, 10349.223808214565, 10441.269111162146, 11134.832977505182, 11152.442377881236, 9013.954930225307, 9262.351635385457, 9298.39560428597, 9304.255659547085, 9385.38994965325], "unit": "ms", "name": "yui.html", "value": 6514.4728351116055}], "name": "dromaeo_css", "value": 7238.835103148369}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 110.0, 103.0, 108.0, 109.0, 109.0, 100.0, 108.0, 106.0, 109.0], "unit": "ms", "name": "ai-astar", "value": 107.1}, {"lowerIsBetter": true, "replicates": [153.0, 120.0, 142.0, 164.0, 131.0, 158.0, 145.0, 125.0, 166.0, 129.0], "unit": "ms", "name": "audio-beat-detection", "value": 143.3}, {"lowerIsBetter": true, "replicates": [160.0, 160.0, 159.0, 160.0, 157.0, 160.0, 158.0, 162.0, 160.0, 158.0], "unit": "ms", "name": "audio-dft", "value": 159.4}, {"lowerIsBetter": true, "replicates": [71.0, 70.0, 71.0, 139.0, 70.0, 72.0, 72.0, 70.0, 153.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 85.9}, {"lowerIsBetter": true, "replicates": [88.0, 87.0, 129.0, 89.0, 90.0, 90.0, 135.0, 89.0, 90.0, 141.0], "unit": "ms", "name": "audio-oscillator", "value": 102.8}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 111.0, 110.0, 110.0, 111.0, 110.0, 110.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.1}, {"lowerIsBetter": true, "replicates": [148.0, 145.0, 146.0, 145.0, 146.0, 146.0, 147.0, 145.0, 146.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.9}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 97.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [55.0, 56.0, 55.0, 55.0, 56.0, 55.0, 56.0, 57.0, 56.0, 53.0], "unit": "ms", "name": "json-parse-financial", "value": 55.4}, {"lowerIsBetter": true, "replicates": [63.0, 63.0, 63.0, 63.0, 63.0, 62.0, 62.0, 63.0, 62.0, 63.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 62.7}, {"lowerIsBetter": true, "replicates": [77.0, 76.0, 78.0, 77.0, 79.0, 77.0, 77.0, 76.0, 77.0, 76.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 77.0}, {"lowerIsBetter": true, "replicates": [123.0, 106.0, 115.0, 118.0, 118.0, 109.0, 114.0, 114.0, 108.0, 125.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 115.0}, {"lowerIsBetter": true, "replicates": [137.0, 142.0, 125.0, 135.0, 135.0, 135.0, 127.0, 137.0, 137.0, 134.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 134.4}, {"lowerIsBetter": true, "replicates": [61.0, 64.0, 64.0, 61.0, 62.0, 62.0, 62.0, 61.0, 64.0, 60.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 62.1}], "name": "kraken", "value": 1456.7}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.5278934221482], "unit": "score", "name": "Richards", "value": 211.98851000000005}, {"lowerIsBetter": false, "replicates": [170.2127659574468], "unit": "score", "name": "DeltaBlue", "value": 388.4432500000001}, {"lowerIsBetter": false, "replicates": [279.4076557697681], "unit": "score", "name": "Encrypt", "value": 952.6617989999997}, {"lowerIsBetter": false, "replicates": [5005.0], "unit": "score", "name": "Decrypt", "value": 53.18301698301701}, {"lowerIsBetter": false, "replicates": [939.8496240601504], "unit": "score", "name": "RayTrace", "value": 787.3482960000001}, {"lowerIsBetter": false, "replicates": [553.7098560354374], "unit": "score", "name": "Earley", "value": 1203.6321779999998}, {"lowerIsBetter": false, "replicates": [10806.451612903225], "unit": "score", "name": "Boyer", "value": 61.67269552238811}, {"lowerIsBetter": false, "replicates": [23227.272727272728], "unit": "score", "name": "RegExp", "value": 39.22048923679059}, {"lowerIsBetter": false, "replicates": [544.3658138268917], "unit": "score", "name": "Splay", "value": 149.69896699999998}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 23228.519234908843}]} 04:13:15 INFO - RETURN: dromaeo_css: 7238.84 04:13:15 INFO - RETURN: kraken: 1456.70 04:13:15 INFO - RETURN: v8_7: 23228.52 04:13:15 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,53,35]]", "result": "23228.52"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,53,35]]", "result": "1456.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,53,35]]", "result": "7238.84"}}} 04:13:15 INFO - Return code: 0 04:13:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 04:13:15 INFO - # TBPL SUCCESS # 04:13:15 INFO - Running post-action listener: _resource_record_post_action 04:13:15 INFO - Running post-run listener: _resource_record_post_run 04:13:16 INFO - Total resource usage - Wall time: 1219s; CPU: 13.0%; Read bytes: 327680; Write bytes: 503623680; Read time: 324; Write time: 369524 04:13:16 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 4096; Write bytes: 238727168; Read time: 12; Write time: 239664 04:13:16 INFO - run-tests - Wall time: 1205s; CPU: 12.0%; Read bytes: 323584; Write bytes: 264896512; Read time: 312; Write time: 129860 04:13:16 INFO - Running post-run listener: _upload_blobber_files 04:13:16 INFO - Blob upload gear active. 04:13:16 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 04:13:16 INFO - Copying logs to upload dir... 04:13:16 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1250.400821 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-01-25 04:13:16.192217) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-25 04:13:16.196163) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1453722744.672701-1797511328 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.009835 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.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-25 04:13:16.247987) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 04:13:16.248343) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1453722744.672701-1797511328 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004519 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 04:13:16.297649) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-25 04:13:16.297994) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-25 04:13:16.298318) ========= ========= Total master_lag: 0.29 =========