builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-022 starttime: 1450737283.44 results: success (0) buildid: 20151221120126 builduid: 7b9770477cf24c75ab6969e5dd77f7eb revision: d48a8bf65a6b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-21 14:34:43.444648) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-21 14:34:43.445125) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-21 14:34:43.445465) ========= 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=b47e8c1238be48f5acbf8f2f000001bb-1450737282.324208-468932590 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006188 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-21 14:34:43.471556) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-21 14:34:43.471876) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-21 14:34:43.489565) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 14:34:43.490001) ========= 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=b47e8c1238be48f5acbf8f2f000001bb-1450737282.324208-468932590 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004550 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 14:34:43.539277) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-21 14:34:43.542626) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-21 14:34:43.542995) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 14:34:43.543279) ========= 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=b47e8c1238be48f5acbf8f2f000001bb-1450737282.324208-468932590 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-21 14:34:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 19.2M=0.001s 2015-12-21 14:34:43 (19.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.162357 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 14:34:43.717870) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 14:34:43.718194) ========= 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=b47e8c1238be48f5acbf8f2f000001bb-1450737282.324208-468932590 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014588 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 14:34:43.769269) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 14:34:43.772084) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev d48a8bf65a6b --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 d48a8bf65a6b --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=b47e8c1238be48f5acbf8f2f000001bb-1450737282.324208-468932590 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-21 14:34:43,832 Setting DEBUG logging. 2015-12-21 14:34:43,832 attempt 1/10 2015-12-21 14:34:43,832 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/d48a8bf65a6b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-21 14:34:44,116 unpacking tar archive at: mozilla-beta-d48a8bf65a6b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.565029 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 14:34:44.349878) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-21 14:34:44.350221) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-21 14:34:44.356609) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-21 14:34:44.356869) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-21 14:34:44.357260) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2015-12-21 14:34:44.357593) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=b47e8c1238be48f5acbf8f2f000001bb-1450737282.324208-468932590 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:34:44 INFO - MultiFileLogger online at 20151221 14:34:44 in /builds/slave/test-pgo 14:34:44 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 14:34:44 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 14:34:44 INFO - {'append_to_log': False, 14:34:44 INFO - 'base_work_dir': '/builds/slave/test-pgo', 14:34:44 INFO - 'blob_upload_branch': 'Mozilla-Beta', 14:34:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 14:34:44 INFO - 'branch': 'Mozilla-Beta', 14:34:44 INFO - 'buildbot_json_path': 'buildprops.json', 14:34:44 INFO - 'config_files': ('talos/linux_config.py',), 14:34:44 INFO - 'default_actions': ('clobber', 14:34:44 INFO - 'read-buildbot-config', 14:34:44 INFO - 'download-and-extract', 14:34:44 INFO - 'populate-webroot', 14:34:44 INFO - 'create-virtualenv', 14:34:44 INFO - 'install', 14:34:44 INFO - 'run-tests'), 14:34:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:34:44 INFO - 'download_minidump_stackwalk': True, 14:34:44 INFO - 'download_symbols': 'ondemand', 14:34:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:34:44 INFO - 'tooltool.py': '/tools/tooltool.py', 14:34:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:34:44 INFO - '/tools/misc-python/virtualenv.py')}, 14:34:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:34:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:34:44 INFO - 'installer_path': 'installer.exe', 14:34:44 INFO - 'log_level': 'info', 14:34:44 INFO - 'log_name': 'talos', 14:34:44 INFO - 'log_to_console': True, 14:34:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:34:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:34:44 INFO - 'opt_config_files': (), 14:34:44 INFO - 'pip_index': False, 14:34:44 INFO - 'sps_profile': False, 14:34:44 INFO - 'sps_profile_interval': 0, 14:34:44 INFO - 'suite': 'dromaeojs', 14:34:44 INFO - 'system_bits': '64', 14:34:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:34:44 INFO - 'title': 'talos-linux64-ix-022', 14:34:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:34:44 INFO - 'use_talos_json': True, 14:34:44 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 14:34:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:34:44 INFO - 'work_dir': 'build'} 14:34:44 INFO - ##### 14:34:44 INFO - ##### Running clobber step. 14:34:44 INFO - ##### 14:34:44 INFO - Running pre-action listener: _resource_record_pre_action 14:34:44 INFO - Running main action method: clobber 14:34:44 INFO - rmtree: /builds/slave/test-pgo/build 14:34:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 14:34:44 INFO - Running post-action listener: _resource_record_post_action 14:34:44 INFO - ##### 14:34:44 INFO - ##### Running read-buildbot-config step. 14:34:44 INFO - ##### 14:34:44 INFO - Running pre-action listener: _resource_record_pre_action 14:34:44 INFO - Running main action method: read_buildbot_config 14:34:44 INFO - Using buildbot properties: 14:34:44 INFO - { 14:34:44 INFO - "properties": { 14:34:44 INFO - "buildnumber": 45, 14:34:44 INFO - "product": "firefox", 14:34:44 INFO - "script_repo_revision": "production", 14:34:44 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 14:34:44 INFO - "repository": "", 14:34:44 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 14:34:44 INFO - "buildid": "20151221120126", 14:34:44 INFO - "slavename": "talos-linux64-ix-022", 14:34:44 INFO - "pgo_build": "True", 14:34:44 INFO - "basedir": "/builds/slave/test-pgo", 14:34:44 INFO - "project": "", 14:34:44 INFO - "platform": "ubuntu64_hw", 14:34:44 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 14:34:44 INFO - "slavebuilddir": "test", 14:34:44 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 14:34:44 INFO - "branch": "mozilla-beta", 14:34:44 INFO - "repo_path": "releases/mozilla-beta", 14:34:44 INFO - "stage_platform": "linux64-pgo", 14:34:44 INFO - "builduid": "7b9770477cf24c75ab6969e5dd77f7eb", 14:34:44 INFO - "revision": "d48a8bf65a6b" 14:34:44 INFO - }, 14:34:44 INFO - "sourcestamp": { 14:34:44 INFO - "repository": "", 14:34:44 INFO - "hasPatch": false, 14:34:44 INFO - "project": "", 14:34:44 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 14:34:44 INFO - "changes": [ 14:34:44 INFO - { 14:34:44 INFO - "category": null, 14:34:44 INFO - "files": [ 14:34:44 INFO - { 14:34:44 INFO - "url": null, 14:34:44 INFO - "name": "http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450728086/firefox-44.0.en-US.linux-x86_64.tar.bz2" 14:34:44 INFO - } 14:34:44 INFO - ], 14:34:44 INFO - "repository": "", 14:34:44 INFO - "rev": "d48a8bf65a6b", 14:34:44 INFO - "who": "sendchange", 14:34:44 INFO - "when": 1450737120, 14:34:44 INFO - "number": 7382905, 14:34:44 INFO - "comments": "Bug 1079858: Backout f301ef5812d5 a=ritu", 14:34:44 INFO - "project": "", 14:34:44 INFO - "at": "Mon 21 Dec 2015 14:32:00", 14:34:44 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 14:34:44 INFO - "revlink": "", 14:34:44 INFO - "properties": [ 14:34:44 INFO - [ 14:34:44 INFO - "buildid", 14:34:44 INFO - "20151221120126", 14:34:44 INFO - "Change" 14:34:44 INFO - ], 14:34:44 INFO - [ 14:34:44 INFO - "builduid", 14:34:44 INFO - "7b9770477cf24c75ab6969e5dd77f7eb", 14:34:44 INFO - "Change" 14:34:44 INFO - ], 14:34:44 INFO - [ 14:34:44 INFO - "pgo_build", 14:34:44 INFO - "True", 14:34:44 INFO - "Change" 14:34:44 INFO - ] 14:34:44 INFO - ], 14:34:44 INFO - "revision": "d48a8bf65a6b" 14:34:44 INFO - } 14:34:44 INFO - ], 14:34:44 INFO - "revision": "d48a8bf65a6b" 14:34:44 INFO - } 14:34:44 INFO - } 14:34:44 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450728086/firefox-44.0.en-US.linux-x86_64.tar.bz2. 14:34:44 INFO - Running post-action listener: _resource_record_post_action 14:34:44 INFO - ##### 14:34:44 INFO - ##### Running download-and-extract step. 14:34:44 INFO - ##### 14:34:44 INFO - Running pre-action listener: _resource_record_pre_action 14:34:44 INFO - Running main action method: download_and_extract 14:34:44 INFO - mkdir: /builds/slave/test-pgo/build/tests 14:34:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:34:44 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450728086/test_packages.json 14:34:44 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450728086/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 14:34:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450728086/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 14:34:45 INFO - Downloaded 1270 bytes. 14:34:45 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 14:34:45 INFO - Using the following test package requirements: 14:34:45 INFO - {u'common': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip'], 14:34:45 INFO - u'cppunittest': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 14:34:45 INFO - u'firefox-44.0.en-US.linux-x86_64.cppunittest.tests.zip'], 14:34:45 INFO - u'jittest': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 14:34:45 INFO - u'jsshell-linux-x86_64.zip'], 14:34:45 INFO - u'mochitest': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 14:34:45 INFO - u'firefox-44.0.en-US.linux-x86_64.mochitest.tests.zip'], 14:34:45 INFO - u'mozbase': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip'], 14:34:45 INFO - u'reftest': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 14:34:45 INFO - u'firefox-44.0.en-US.linux-x86_64.reftest.tests.zip'], 14:34:45 INFO - u'talos': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 14:34:45 INFO - u'firefox-44.0.en-US.linux-x86_64.talos.tests.zip'], 14:34:45 INFO - u'web-platform': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 14:34:45 INFO - u'firefox-44.0.en-US.linux-x86_64.web-platform.tests.zip'], 14:34:45 INFO - u'webapprt': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip'], 14:34:45 INFO - u'xpcshell': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 14:34:45 INFO - u'firefox-44.0.en-US.linux-x86_64.xpcshell.tests.zip']} 14:34:45 INFO - Downloading packages: [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:34:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:34:45 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450728086/firefox-44.0.en-US.linux-x86_64.common.tests.zip 14:34:45 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450728086/firefox-44.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip 14:34:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450728086/firefox-44.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:34:45 INFO - Downloaded 22572762 bytes. 14:34:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 14:34:45 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip 14:34:45 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 14:34:46 INFO - Return code: 0 14:34:46 INFO - Downloading packages: [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', u'firefox-44.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:34:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:34:46 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450728086/firefox-44.0.en-US.linux-x86_64.common.tests.zip 14:34:46 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450728086/firefox-44.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip 14:34:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450728086/firefox-44.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:34:48 INFO - Downloaded 22572762 bytes. 14:34:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 14:34:48 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip 14:34:48 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 14:34:49 INFO - Return code: 0 14:34:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:34:49 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450728086/firefox-44.0.en-US.linux-x86_64.talos.tests.zip 14:34:49 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450728086/firefox-44.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.talos.tests.zip 14:34:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450728086/firefox-44.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:34:51 INFO - Downloaded 11131970 bytes. 14:34:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 14:34:51 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.talos.tests.zip 14:34:51 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 14:34:51 INFO - Return code: 0 14:34:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:34:51 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450728086/firefox-44.0.en-US.linux-x86_64.tar.bz2 14:34:51 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450728086/firefox-44.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.tar.bz2 14:34:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450728086/firefox-44.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:34:59 INFO - Downloaded 56617436 bytes. 14:34:59 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450728086/firefox-44.0.en-US.linux-x86_64.tar.bz2 14:34:59 INFO - mkdir: /builds/slave/test-pgo/properties 14:34:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 14:34:59 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 14:34:59 INFO - Contents: 14:34:59 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450728086/firefox-44.0.en-US.linux-x86_64.tar.bz2 14:34:59 INFO - Running post-action listener: _resource_record_post_action 14:34:59 INFO - Running post-action listener: set_extra_try_arguments 14:34:59 INFO - ##### 14:34:59 INFO - ##### Running populate-webroot step. 14:34:59 INFO - ##### 14:34:59 INFO - Running pre-action listener: _resource_record_pre_action 14:34:59 INFO - Running main action method: populate_webroot 14:34:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:34:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:34:59 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 14:34:59 INFO - '../fennec_ids.txt'], 14:34:59 INFO - 'tests': ['tcheck2']}, 14:34:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:34:59 INFO - '--tppagecycles', 14:34:59 INFO - '7'], 14:34:59 INFO - 'tests': ['tsvgm']}}, 14:34:59 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:34:59 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:34:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:34:59 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:34:59 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:34:59 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:34:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:34:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:34:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:34:59 INFO - 'talos_options': ['--e10s'], 14:34:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:34:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:34:59 INFO - 'tests': ['damp', 'tps']}, 14:34:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:34:59 INFO - 'talos_options': ['--e10s'], 14:34:59 INFO - 'tests': ['damp', 'tps']}, 14:34:59 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:34:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:34:59 INFO - 'other': {'tests': ['a11yr', 14:34:59 INFO - 'ts_paint', 14:34:59 INFO - 'tpaint', 14:34:59 INFO - 'sessionrestore', 14:34:59 INFO - 'sessionrestore_no_auto_restore']}, 14:34:59 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:34:59 INFO - 'tests': ['a11yr', 14:34:59 INFO - 'ts_paint', 14:34:59 INFO - 'tpaint', 14:34:59 INFO - 'sessionrestore', 14:34:59 INFO - 'sessionrestore_no_auto_restore']}, 14:34:59 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:34:59 INFO - 'tests': ['a11yr', 14:34:59 INFO - 'ts_paint', 14:34:59 INFO - 'tpaint', 14:34:59 INFO - 'sessionrestore', 14:34:59 INFO - 'sessionrestore_no_auto_restore']}, 14:34:59 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:34:59 INFO - 'tests': ['a11yr', 14:34:59 INFO - 'ts_paint', 14:34:59 INFO - 'tpaint', 14:34:59 INFO - 'sessionrestore', 14:34:59 INFO - 'sessionrestore_no_auto_restore']}, 14:34:59 INFO - 'other_l64': {'tests': ['a11yr', 14:34:59 INFO - 'ts_paint', 14:34:59 INFO - 'tpaint', 14:34:59 INFO - 'sessionrestore', 14:34:59 INFO - 'sessionrestore_no_auto_restore']}, 14:34:59 INFO - 'other_nol64': {'tests': ['a11yr', 14:34:59 INFO - 'ts_paint', 14:34:59 INFO - 'tpaint', 14:34:59 INFO - 'sessionrestore', 14:34:59 INFO - 'sessionrestore_no_auto_restore']}, 14:34:59 INFO - 'svgr': {'tests': ['tsvgx', 14:34:59 INFO - 'tsvgr_opacity', 14:34:59 INFO - 'tart', 14:34:59 INFO - 'tscrollx', 14:34:59 INFO - 'cart']}, 14:34:59 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:34:59 INFO - 'tests': ['tsvgx', 14:34:59 INFO - 'tsvgr_opacity', 14:34:59 INFO - 'tart', 14:34:59 INFO - 'tscrollx', 14:34:59 INFO - 'cart']}, 14:34:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:34:59 INFO - 'tests': ['tp5o']}, 14:34:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:34:59 INFO - 'talos_options': ['--e10s'], 14:34:59 INFO - 'tests': ['tp5o']}, 14:34:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:34:59 INFO - 'talos_options': ['--xperf_path', 14:34:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:34:59 INFO - 'tests': ['tp5n']}, 14:34:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:34:59 INFO - 'talos_options': ['--e10s', 14:34:59 INFO - '--xperf_path', 14:34:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:34:59 INFO - 'tests': ['tp5n']}}, 14:34:59 INFO - 'talos.zip': {'path': '', 14:34:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:34:59 INFO - Running post-action listener: _resource_record_post_action 14:34:59 INFO - ##### 14:34:59 INFO - ##### Running create-virtualenv step. 14:34:59 INFO - ##### 14:34:59 INFO - Running pre-action listener: _resource_record_pre_action 14:34:59 INFO - Running main action method: create_virtualenv 14:34:59 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 14:34:59 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 14:34:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 14:34:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:34:59 INFO - Using real prefix '/usr' 14:34:59 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 14:34:59 INFO - Installing distribute.............................................................................................................................................................................................done. 14:35:01 INFO - Installing pip.................done. 14:35:01 INFO - Return code: 0 14:35:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 14:35:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:35:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:35:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:35:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:35:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f322f4f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a4e600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2add350>, '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 0x2ade250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ade6e0>, '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': 'b47e8c1238be48f5acbf8f2f000001bb-1450737282.324208-468932590', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:35:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 14:35:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:35:01 INFO - Using env: {'DISPLAY': ':0', 14:35:01 INFO - 'HOME': '/home/cltbld', 14:35:01 INFO - 'LANG': 'en_US.UTF-8', 14:35:01 INFO - 'LANGUAGE': 'en_US:en', 14:35:01 INFO - 'LOGNAME': 'cltbld', 14:35:01 INFO - 'MAIL': '/var/mail/cltbld', 14:35:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:35:01 INFO - 'MOZ_NO_REMOTE': '1', 14:35:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:35:01 INFO - 'NO_EM_RESTART': '1', 14:35:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:35:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:35:01 INFO - 'PWD': '/builds/slave/test-pgo', 14:35:01 INFO - 'SHELL': '/bin/bash', 14:35:01 INFO - 'SHLVL': '1', 14:35:01 INFO - 'TERM': 'linux', 14:35:01 INFO - 'TMOUT': '86400', 14:35:01 INFO - 'USER': 'cltbld', 14:35:01 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450737282.324208-468932590', 14:35:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:35:01 INFO - '_': '/tools/buildbot/bin/python'} 14:35:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:35:02 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:35:02 INFO - Cleaning up... 14:35:02 INFO - Return code: 0 14:35:02 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 14:35:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:35:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:35:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:35:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:35:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:02 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 0x7f322f4f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a4e600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2add350>, '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 0x2ade250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ade6e0>, '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': 'b47e8c1238be48f5acbf8f2f000001bb-1450737282.324208-468932590', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:35:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 14:35:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 14:35:02 INFO - Using env: {'DISPLAY': ':0', 14:35:02 INFO - 'HOME': '/home/cltbld', 14:35:02 INFO - 'LANG': 'en_US.UTF-8', 14:35:02 INFO - 'LANGUAGE': 'en_US:en', 14:35:02 INFO - 'LOGNAME': 'cltbld', 14:35:02 INFO - 'MAIL': '/var/mail/cltbld', 14:35:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:35:02 INFO - 'MOZ_NO_REMOTE': '1', 14:35:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:35:02 INFO - 'NO_EM_RESTART': '1', 14:35:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:35:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:35:02 INFO - 'PWD': '/builds/slave/test-pgo', 14:35:02 INFO - 'SHELL': '/bin/bash', 14:35:02 INFO - 'SHLVL': '1', 14:35:02 INFO - 'TERM': 'linux', 14:35:02 INFO - 'TMOUT': '86400', 14:35:02 INFO - 'USER': 'cltbld', 14:35:02 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450737282.324208-468932590', 14:35:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:35:02 INFO - '_': '/tools/buildbot/bin/python'} 14:35:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:35:02 INFO - Downloading/unpacking psutil>=0.7.1 14:35:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:35:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:35:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:35:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:35:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:35:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:35:03 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 14:35:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 14:35:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 14:35:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:35:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:35:04 INFO - Installing collected packages: psutil 14:35:04 INFO - Running setup.py install for psutil 14:35:04 INFO - building 'psutil._psutil_linux' extension 14:35:04 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 14:35:04 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 14:35:04 INFO - building 'psutil._psutil_posix' extension 14:35:04 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 14:35:04 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 14:35:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:35:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:35:04 INFO - Successfully installed psutil 14:35:04 INFO - Cleaning up... 14:35:04 INFO - Return code: 0 14:35:04 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 14:35:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:35:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:35:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:35:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:35:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:04 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f322f4f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a4e600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2add350>, '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 0x2ade250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ade6e0>, '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': 'b47e8c1238be48f5acbf8f2f000001bb-1450737282.324208-468932590', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:35:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 14:35:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 14:35:04 INFO - Using env: {'DISPLAY': ':0', 14:35:04 INFO - 'HOME': '/home/cltbld', 14:35:04 INFO - 'LANG': 'en_US.UTF-8', 14:35:04 INFO - 'LANGUAGE': 'en_US:en', 14:35:04 INFO - 'LOGNAME': 'cltbld', 14:35:04 INFO - 'MAIL': '/var/mail/cltbld', 14:35:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:35:04 INFO - 'MOZ_NO_REMOTE': '1', 14:35:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:35:04 INFO - 'NO_EM_RESTART': '1', 14:35:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:35:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:35:04 INFO - 'PWD': '/builds/slave/test-pgo', 14:35:04 INFO - 'SHELL': '/bin/bash', 14:35:04 INFO - 'SHLVL': '1', 14:35:04 INFO - 'TERM': 'linux', 14:35:04 INFO - 'TMOUT': '86400', 14:35:04 INFO - 'USER': 'cltbld', 14:35:04 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450737282.324208-468932590', 14:35:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:35:04 INFO - '_': '/tools/buildbot/bin/python'} 14:35:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:35:04 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:35:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:35:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:35:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:35:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:35:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:35:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:35:06 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:35:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 14:35:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:35:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:35:06 INFO - Installing collected packages: mozsystemmonitor 14:35:06 INFO - Running setup.py install for mozsystemmonitor 14:35:06 INFO - Successfully installed mozsystemmonitor 14:35:06 INFO - Cleaning up... 14:35:07 INFO - Return code: 0 14:35:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 14:35:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:35:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:35:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:35:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:35:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:07 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f322f4f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a4e600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2add350>, '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 0x2ade250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ade6e0>, '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': 'b47e8c1238be48f5acbf8f2f000001bb-1450737282.324208-468932590', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:35:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 14:35:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:35:07 INFO - Using env: {'DISPLAY': ':0', 14:35:07 INFO - 'HOME': '/home/cltbld', 14:35:07 INFO - 'LANG': 'en_US.UTF-8', 14:35:07 INFO - 'LANGUAGE': 'en_US:en', 14:35:07 INFO - 'LOGNAME': 'cltbld', 14:35:07 INFO - 'MAIL': '/var/mail/cltbld', 14:35:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:35:07 INFO - 'MOZ_NO_REMOTE': '1', 14:35:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:35:07 INFO - 'NO_EM_RESTART': '1', 14:35:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:35:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:35:07 INFO - 'PWD': '/builds/slave/test-pgo', 14:35:07 INFO - 'SHELL': '/bin/bash', 14:35:07 INFO - 'SHLVL': '1', 14:35:07 INFO - 'TERM': 'linux', 14:35:07 INFO - 'TMOUT': '86400', 14:35:07 INFO - 'USER': 'cltbld', 14:35:07 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450737282.324208-468932590', 14:35:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:35:07 INFO - '_': '/tools/buildbot/bin/python'} 14:35:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:35:07 INFO - Downloading/unpacking blobuploader==1.2.4 14:35:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:35:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:35:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:35:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:35:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:35:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:35:09 INFO - Downloading blobuploader-1.2.4.tar.gz 14:35:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 14:35:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:35:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:35:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:35:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:35:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:35:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:35:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:35:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:35:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 14:35:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 14:35:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:35:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:35:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:35:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:35:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:35:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:35:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:35:10 INFO - Downloading docopt-0.6.1.tar.gz 14:35:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 14:35:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 14:35:10 INFO - Installing collected packages: blobuploader, requests, docopt 14:35:10 INFO - Running setup.py install for blobuploader 14:35:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:35:10 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 14:35:10 INFO - Running setup.py install for requests 14:35:10 INFO - Running setup.py install for docopt 14:35:10 INFO - Successfully installed blobuploader requests docopt 14:35:10 INFO - Cleaning up... 14:35:10 INFO - Return code: 0 14:35:10 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:35: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')]} 14:35:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:35:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35: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')]} 14:35:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:35:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:10 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 0x7f322f4f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a4e600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2add350>, '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 0x2ade250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ade6e0>, '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': 'b47e8c1238be48f5acbf8f2f000001bb-1450737282.324208-468932590', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:35:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 14:35:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:35:10 INFO - Using env: {'DISPLAY': ':0', 14:35:10 INFO - 'HOME': '/home/cltbld', 14:35:10 INFO - 'LANG': 'en_US.UTF-8', 14:35:10 INFO - 'LANGUAGE': 'en_US:en', 14:35:10 INFO - 'LOGNAME': 'cltbld', 14:35:10 INFO - 'MAIL': '/var/mail/cltbld', 14:35:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:35:10 INFO - 'MOZ_NO_REMOTE': '1', 14:35:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:35:10 INFO - 'NO_EM_RESTART': '1', 14:35:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:35:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:35:10 INFO - 'PWD': '/builds/slave/test-pgo', 14:35:10 INFO - 'SHELL': '/bin/bash', 14:35:10 INFO - 'SHLVL': '1', 14:35:10 INFO - 'TERM': 'linux', 14:35:10 INFO - 'TMOUT': '86400', 14:35:10 INFO - 'USER': 'cltbld', 14:35:10 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450737282.324208-468932590', 14:35:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:35:10 INFO - '_': '/tools/buildbot/bin/python'} 14:35:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:35:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:35:11 INFO - Running setup.py (path:/tmp/pip-_eTcGV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:35:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:35:11 INFO - Running setup.py (path:/tmp/pip-5stcrA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:35:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:35:11 INFO - Running setup.py (path:/tmp/pip-bfO0Yg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:35:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:35:11 INFO - Running setup.py (path:/tmp/pip-0om6zq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:35:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 14:35:11 INFO - Running setup.py (path:/tmp/pip-tuPqj5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 14:35:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:35:11 INFO - Running setup.py (path:/tmp/pip-wLdO4T-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:35:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:35:11 INFO - Running setup.py (path:/tmp/pip-43Q9zA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:35:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:35:11 INFO - Running setup.py (path:/tmp/pip-EQiL7r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:35:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 14:35:11 INFO - Running setup.py (path:/tmp/pip-_uj4Wf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 14:35:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 14:35:11 INFO - Running setup.py (path:/tmp/pip-nJsvAn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 14:35:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:35:11 INFO - Running setup.py (path:/tmp/pip-RoH2k7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:35:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:35:11 INFO - Running setup.py (path:/tmp/pip-y6tTBv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:35:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:35:11 INFO - Running setup.py (path:/tmp/pip-dCdxPc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:35:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:35:11 INFO - Running setup.py (path:/tmp/pip-LwQe8d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:35:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:35:12 INFO - Running setup.py (path:/tmp/pip-JEE7OK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:35:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 14:35:12 INFO - Running setup.py (path:/tmp/pip-TvNyX1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 14:35:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 14:35:12 INFO - Running setup.py (path:/tmp/pip-wQmQsR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 14:35:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:35:12 INFO - Running setup.py install for manifestparser 14:35:12 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 14:35:12 INFO - Running setup.py install for mozcrash 14:35:12 INFO - Running setup.py install for mozdebug 14:35:12 INFO - Running setup.py install for mozdevice 14:35:12 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 14:35:12 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 14:35:12 INFO - Running setup.py install for mozfile 14:35:12 INFO - Running setup.py install for mozhttpd 14:35:12 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 14:35:12 INFO - Running setup.py install for mozinfo 14:35:12 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 14:35:12 INFO - Running setup.py install for mozInstall 14:35:13 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 14:35:13 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 14:35:13 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 14:35:13 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 14:35:13 INFO - Running setup.py install for mozleak 14:35:13 INFO - Running setup.py install for mozlog 14:35:13 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 14:35:13 INFO - Running setup.py install for moznetwork 14:35:13 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 14:35:13 INFO - Running setup.py install for mozprocess 14:35:13 INFO - Running setup.py install for mozprofile 14:35:13 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 14:35:13 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 14:35:13 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 14:35:13 INFO - Running setup.py install for mozrunner 14:35:13 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 14:35:13 INFO - Running setup.py install for mozscreenshot 14:35:13 INFO - Running setup.py install for moztest 14:35:13 INFO - Running setup.py install for mozversion 14:35:13 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 14:35:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:35:13 INFO - Cleaning up... 14:35:14 INFO - Return code: 0 14:35:14 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:35:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:35:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:35:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:35:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:35:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:14 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 0x7f322f4f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a4e600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2add350>, '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 0x2ade250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ade6e0>, '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': 'b47e8c1238be48f5acbf8f2f000001bb-1450737282.324208-468932590', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:35:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 14:35:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:35:14 INFO - Using env: {'DISPLAY': ':0', 14:35:14 INFO - 'HOME': '/home/cltbld', 14:35:14 INFO - 'LANG': 'en_US.UTF-8', 14:35:14 INFO - 'LANGUAGE': 'en_US:en', 14:35:14 INFO - 'LOGNAME': 'cltbld', 14:35:14 INFO - 'MAIL': '/var/mail/cltbld', 14:35:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:35:14 INFO - 'MOZ_NO_REMOTE': '1', 14:35:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:35:14 INFO - 'NO_EM_RESTART': '1', 14:35:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:35:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:35:14 INFO - 'PWD': '/builds/slave/test-pgo', 14:35:14 INFO - 'SHELL': '/bin/bash', 14:35:14 INFO - 'SHLVL': '1', 14:35:14 INFO - 'TERM': 'linux', 14:35:14 INFO - 'TMOUT': '86400', 14:35:14 INFO - 'USER': 'cltbld', 14:35:14 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450737282.324208-468932590', 14:35:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:35:14 INFO - '_': '/tools/buildbot/bin/python'} 14:35:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:35:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:35:14 INFO - Running setup.py (path:/tmp/pip-1d_aLi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:35:14 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 14:35:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:35:14 INFO - Running setup.py (path:/tmp/pip-lVG20I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:35:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 14:35:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:35:14 INFO - Running setup.py (path:/tmp/pip-MTwnPn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:35:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 14:35:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:35:14 INFO - Running setup.py (path:/tmp/pip-w90VGp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:35:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.46 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 14:35:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 14:35:14 INFO - Running setup.py (path:/tmp/pip-KJ58jN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 14:35:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 14:35:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:35:14 INFO - Running setup.py (path:/tmp/pip-MpBEIn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:35:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 14:35:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:35:14 INFO - Running setup.py (path:/tmp/pip-WBGo1b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:35:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.8 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 14:35:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:35:14 INFO - Running setup.py (path:/tmp/pip-_tJuqv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:35:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 14:35:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 14:35:14 INFO - Running setup.py (path:/tmp/pip-_zSbjU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 14:35:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 14:35:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 14:35:14 INFO - Running setup.py (path:/tmp/pip-ramOkp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 14:35:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 14:35:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:35:14 INFO - Running setup.py (path:/tmp/pip-4XXd93-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:35:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 14:35:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:35:15 INFO - Running setup.py (path:/tmp/pip-kPpXRx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:35:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 14:35:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:35:15 INFO - Running setup.py (path:/tmp/pip-BBckEj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:35:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 14:35:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:35:15 INFO - Running setup.py (path:/tmp/pip-LGDxCy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:35:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 14:35:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:35:15 INFO - Running setup.py (path:/tmp/pip-Q_F_UM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:35:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 14:35:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 14:35:15 INFO - Running setup.py (path:/tmp/pip-Tr3wor-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 14:35:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 14:35:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 14:35:15 INFO - Running setup.py (path:/tmp/pip-SckGgH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 14:35:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 14:35:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 14:35:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 14:35:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 14:35:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.46->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 14:35:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.46->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 14:35:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 14:35:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:35:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:35:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:35:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:35:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:35:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:35:17 INFO - Downloading blessings-1.5.1.tar.gz 14:35:17 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 14:35:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 14:35:17 INFO - Installing collected packages: blessings 14:35:17 INFO - Running setup.py install for blessings 14:35:17 INFO - Successfully installed blessings 14:35:17 INFO - Cleaning up... 14:35:17 INFO - Return code: 0 14:35:17 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 14:35:17 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 14:35:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 14:35:17 INFO - Reading from file tmpfile_stdout 14:35:17 INFO - Current package versions: 14:35:17 INFO - argparse == 1.2.1 14:35:17 INFO - blessings == 1.5.1 14:35:17 INFO - blobuploader == 1.2.4 14:35:17 INFO - docopt == 0.6.1 14:35:17 INFO - manifestparser == 1.1 14:35:17 INFO - mozInstall == 1.12 14:35:17 INFO - mozcrash == 0.16 14:35:17 INFO - mozdebug == 0.1 14:35:17 INFO - mozdevice == 0.46 14:35:17 INFO - mozfile == 1.2 14:35:17 INFO - mozhttpd == 0.7 14:35:17 INFO - mozinfo == 0.8 14:35:17 INFO - mozleak == 0.1 14:35:17 INFO - mozlog == 3.0 14:35:17 INFO - moznetwork == 0.27 14:35:17 INFO - mozprocess == 0.22 14:35:17 INFO - mozprofile == 0.27 14:35:17 INFO - mozrunner == 6.11 14:35:17 INFO - mozscreenshot == 0.1 14:35:17 INFO - mozsystemmonitor == 0.0 14:35:17 INFO - moztest == 0.7 14:35:17 INFO - mozversion == 1.4 14:35:17 INFO - psutil == 3.1.1 14:35:17 INFO - requests == 1.2.3 14:35:17 INFO - wsgiref == 0.1.2 14:35:17 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:35:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:35:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:35:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:35:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:35:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:17 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 0x7f322f4f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a4e600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2add350>, '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 0x2ade250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ade6e0>, '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': 'b47e8c1238be48f5acbf8f2f000001bb-1450737282.324208-468932590', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:35:17 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 14:35:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:35:17 INFO - Using env: {'DISPLAY': ':0', 14:35:17 INFO - 'HOME': '/home/cltbld', 14:35:17 INFO - 'LANG': 'en_US.UTF-8', 14:35:17 INFO - 'LANGUAGE': 'en_US:en', 14:35:17 INFO - 'LOGNAME': 'cltbld', 14:35:17 INFO - 'MAIL': '/var/mail/cltbld', 14:35:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:35:17 INFO - 'MOZ_NO_REMOTE': '1', 14:35:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:35:17 INFO - 'NO_EM_RESTART': '1', 14:35:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:35:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:35:17 INFO - 'PWD': '/builds/slave/test-pgo', 14:35:17 INFO - 'SHELL': '/bin/bash', 14:35:17 INFO - 'SHLVL': '1', 14:35:17 INFO - 'TERM': 'linux', 14:35:17 INFO - 'TMOUT': '86400', 14:35:17 INFO - 'USER': 'cltbld', 14:35:17 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450737282.324208-468932590', 14:35:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:35:17 INFO - '_': '/tools/buildbot/bin/python'} 14:35:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:35:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 14:35:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 14:35:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 14:35:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 14:35:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 14:35:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 14:35:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 14:35:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 14:35:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 14:35:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 14:35:17 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 14:35:17 INFO - Cleaning up... 14:35:17 INFO - Return code: 0 14:35:17 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 14:35:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:35:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:35:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:35:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:35:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:17 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 0x7f322f4f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a4e600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2add350>, '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 0x2ade250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ade6e0>, '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': 'b47e8c1238be48f5acbf8f2f000001bb-1450737282.324208-468932590', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:35:17 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 14:35:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:35:17 INFO - Using env: {'DISPLAY': ':0', 14:35:17 INFO - 'HOME': '/home/cltbld', 14:35:17 INFO - 'LANG': 'en_US.UTF-8', 14:35:17 INFO - 'LANGUAGE': 'en_US:en', 14:35:17 INFO - 'LOGNAME': 'cltbld', 14:35:17 INFO - 'MAIL': '/var/mail/cltbld', 14:35:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:35:17 INFO - 'MOZ_NO_REMOTE': '1', 14:35:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:35:17 INFO - 'NO_EM_RESTART': '1', 14:35:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:35:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:35:17 INFO - 'PWD': '/builds/slave/test-pgo', 14:35:17 INFO - 'SHELL': '/bin/bash', 14:35:17 INFO - 'SHLVL': '1', 14:35:17 INFO - 'TERM': 'linux', 14:35:17 INFO - 'TMOUT': '86400', 14:35:17 INFO - 'USER': 'cltbld', 14:35:17 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450737282.324208-468932590', 14:35:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:35:17 INFO - '_': '/tools/buildbot/bin/python'} 14:35:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:35:18 INFO - Downloading/unpacking jsonschema 14:35:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:35:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:35:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:35:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:35:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:35:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:35:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:35:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 14:35:19 INFO - Downloading/unpacking functools32 (from jsonschema) 14:35:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:35:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:35:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:35:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:35:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:35:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:35:19 INFO - Downloading functools32-3.2.3-2.tar.gz 14:35:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 14:35:19 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 14:35:19 INFO - warning: no files found matching '*.txt' 14:35:19 INFO - no previously-included directories found matching 'build' 14:35:19 INFO - no previously-included directories found matching 'dist' 14:35:19 INFO - no previously-included directories found matching '.git*' 14:35:19 INFO - Installing collected packages: jsonschema, functools32 14:35:20 INFO - Running setup.py install for functools32 14:35:20 INFO - warning: no files found matching '*.txt' 14:35:20 INFO - no previously-included directories found matching 'build' 14:35:20 INFO - no previously-included directories found matching 'dist' 14:35:20 INFO - no previously-included directories found matching '.git*' 14:35:20 INFO - Successfully installed jsonschema functools32 14:35:20 INFO - Cleaning up... 14:35:20 INFO - Return code: 0 14:35:20 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 14:35:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:35:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:35:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:35:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:35:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:20 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 0x7f322f4f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a4e600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2add350>, '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 0x2ade250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ade6e0>, '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': 'b47e8c1238be48f5acbf8f2f000001bb-1450737282.324208-468932590', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:35:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 14:35:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 14:35:20 INFO - Using env: {'DISPLAY': ':0', 14:35:20 INFO - 'HOME': '/home/cltbld', 14:35:20 INFO - 'LANG': 'en_US.UTF-8', 14:35:20 INFO - 'LANGUAGE': 'en_US:en', 14:35:20 INFO - 'LOGNAME': 'cltbld', 14:35:20 INFO - 'MAIL': '/var/mail/cltbld', 14:35:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:35:20 INFO - 'MOZ_NO_REMOTE': '1', 14:35:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:35:20 INFO - 'NO_EM_RESTART': '1', 14:35:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:35:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:35:20 INFO - 'PWD': '/builds/slave/test-pgo', 14:35:20 INFO - 'SHELL': '/bin/bash', 14:35:20 INFO - 'SHLVL': '1', 14:35:20 INFO - 'TERM': 'linux', 14:35:20 INFO - 'TMOUT': '86400', 14:35:20 INFO - 'USER': 'cltbld', 14:35:20 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450737282.324208-468932590', 14:35:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:35:20 INFO - '_': '/tools/buildbot/bin/python'} 14:35:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:35:20 INFO - Downloading/unpacking flake8 14:35:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:35:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:35:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:35:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:35:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:35:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:35:22 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:35:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 14:35:22 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:35:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:35:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:35:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:35:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:35:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:35:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:35:22 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:35:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 14:35:22 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:35:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:35:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:35:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:35:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:35:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:35:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:35:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 14:35:22 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:35:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:35:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:35:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:35:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:35:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:35:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:35:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 14:35:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 14:35:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:35:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:35:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:35:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:35:22 INFO - no previously-included directories found matching 'docs/_build' 14:35:22 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:35:22 INFO - Running setup.py install for pep8 14:35:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:35:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:35:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:35:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:35:22 INFO - no previously-included directories found matching 'docs/_build' 14:35:22 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 14:35:22 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:35:22 INFO - Cleaning up... 14:35:22 INFO - Return code: 0 14:35:22 INFO - Running post-action listener: _resource_record_post_action 14:35:22 INFO - Running post-action listener: _start_resource_monitoring 14:35:22 INFO - Starting resource monitoring. 14:35:22 INFO - ##### 14:35:22 INFO - ##### Running install step. 14:35:22 INFO - ##### 14:35:22 INFO - Running pre-action listener: _resource_record_pre_action 14:35:22 INFO - Running main action method: install 14:35:22 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 14:35:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 14:35:23 INFO - Reading from file tmpfile_stdout 14:35:23 INFO - Detecting whether we're running mozinstall >=1.0... 14:35:23 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 14:35:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 14:35:23 INFO - Reading from file tmpfile_stdout 14:35:23 INFO - Output received: 14:35:23 INFO - Usage: mozinstall [options] installer 14:35:23 INFO - Options: 14:35:23 INFO - -h, --help show this help message and exit 14:35:23 INFO - -d DEST, --destination=DEST 14:35:23 INFO - Directory to install application into. [default: 14:35:23 INFO - "/builds/slave/test-pgo"] 14:35:23 INFO - --app=APP Application being installed. [default: firefox] 14:35:23 INFO - mkdir: /builds/slave/test-pgo/build/application 14:35:23 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 14:35:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 14:35:37 INFO - Reading from file tmpfile_stdout 14:35:37 INFO - Output received: 14:35:37 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 14:35:37 INFO - Running post-action listener: _resource_record_post_action 14:35:37 INFO - ##### 14:35:37 INFO - ##### Running run-tests step. 14:35:37 INFO - ##### 14:35:37 INFO - Running pre-action listener: _resource_record_pre_action 14:35:37 INFO - Running main action method: run_tests 14:35:37 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 14:35:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 14:35:37 INFO - Python 2.7.3 14:35:37 INFO - Return code: 0 14:35:37 INFO - grabbing minidump binary from tooltool 14:35:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:35:37 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 0x2add350>, '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 0x2ade250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ade6e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 14:35:37 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 14:35:37 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 14:35:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:35:37 INFO - Return code: 0 14:35:37 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 14:35:37 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 14:35:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 14:35:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 14:35:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 14:35:37 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 14:35:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 14:35:38 INFO - Return code: 0 14:35:38 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/1450728086/firefox-44.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 14:35:38 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/1450728086/firefox-44.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-022 --webServer localhost 14:35:38 INFO - Using env: {'DISPLAY': ':0', 14:35:38 INFO - 'HOME': '/home/cltbld', 14:35:38 INFO - 'LANG': 'en_US.UTF-8', 14:35:38 INFO - 'LANGUAGE': 'en_US:en', 14:35:38 INFO - 'LOGNAME': 'cltbld', 14:35:38 INFO - 'MAIL': '/var/mail/cltbld', 14:35:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 14:35:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 14:35:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:35:38 INFO - 'MOZ_NO_REMOTE': '1', 14:35:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 14:35:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:35:38 INFO - 'NO_EM_RESTART': '1', 14:35:38 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:35:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:35:38 INFO - 'PWD': '/builds/slave/test-pgo', 14:35:38 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 14:35:38 INFO - 'SHELL': '/bin/bash', 14:35:38 INFO - 'SHLVL': '1', 14:35:38 INFO - 'TERM': 'linux', 14:35:38 INFO - 'TMOUT': '86400', 14:35:38 INFO - 'USER': 'cltbld', 14:35:38 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450737282.324208-468932590', 14:35:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:35:38 INFO - '_': '/tools/buildbot/bin/python'} 14:35:38 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/1450728086/firefox-44.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--webServer', 'localhost'] with output_timeout 3600 14:35:38 INFO - mozversion INFO | application_buildid: 20151221120126 14:35:38 INFO - mozversion INFO | application_changeset: d48a8bf65a6b71bfc47f07cd4dee19921cfbf7cd 14:35:38 INFO - mozversion INFO | application_display_name: Nightly 14:35:38 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:35:38 INFO - mozversion INFO | application_name: Firefox 14:35:38 INFO - mozversion INFO | application_remotingname: firefox 14:35:38 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-beta 14:35:38 INFO - mozversion INFO | application_vendor: Mozilla 14:35:38 INFO - mozversion INFO | application_version: 44.0 14:35:38 INFO - mozversion INFO | platform_buildid: 20151221120126 14:35:38 INFO - mozversion INFO | platform_changeset: d48a8bf65a6b71bfc47f07cd4dee19921cfbf7cd 14:35:38 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-beta 14:35:38 INFO - mozversion INFO | platform_version: 43.0 14:35:38 INFO - 2015-12-21 14:35:38,733 DEBUG : using testdate: 1450737338 14:35:38 INFO - 2015-12-21 14:35:38,733 DEBUG : actual date: 1450737338 14:35:38 INFO - 2015-12-21 14:35:38,807 INFO : starting webserver on 'localhost:44258' 14:35:38 INFO - 2015-12-21 14:35:38,808 INFO : Starting test suite talos-linux64-ix-022 14:35:38 INFO - 2015-12-21 14:35:38,808 INFO : Starting test dromaeo_css 14:35:38 INFO - 2015-12-21 14:35:38,808 DEBUG : operating with platform_type : linux_ 14:35:38 INFO - 2015-12-21 14:35:38,809 INFO : Initialising browser for dromaeo_css test... 14:35:38 INFO - 2015-12-21 14:35:38,823 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9J65xM/profile http://localhost:44258/getInfo.html 14:35:43 INFO - 2015-12-21 14:35:43,266 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:35:43 INFO - 2015-12-21 14:35:43,267 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:35:43 INFO - 2015-12-21 14:35:43,267 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 14:35:43 INFO - 2015-12-21 14:35:43,267 DEBUG : BROWSER_OUTPUT: __metrics 14:35:43 INFO - 2015-12-21 14:35:43,363 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:35:44 INFO - 2015-12-21 14:35:44,666 INFO : Browser initialized. 14:35:44 INFO - 2015-12-21 14:35:44,667 INFO : Running cycle 1/1 for dromaeo_css test... 14:35:44 INFO - 2015-12-21 14:35:44,667 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9J65xM/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:35:56 INFO - 2015-12-21 14:35:56,145 DEBUG : BROWSER_OUTPUT: RSS: Main: 129134592 14:35:56 INFO - 2015-12-21 14:35:56,146 DEBUG : BROWSER_OUTPUT: 14:36:46 INFO - 2015-12-21 14:36:46,931 DEBUG : BROWSER_OUTPUT: 1450737406928 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 14:38:54 INFO - 2015-12-21 14:38:54,784 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44258/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44258/tests/dromaeo/cssquery-ext.html) 14:38:55 INFO - 2015-12-21 14:38:55,854 DEBUG : BROWSER_OUTPUT: RSS: Main: 204439552 14:38:55 INFO - 2015-12-21 14:38:55,854 DEBUG : BROWSER_OUTPUT: 14:41:57 INFO - 2015-12-21 14:41:57,958 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44258/tests/dromaeo/cssquery-ext.html (next: http://localhost:44258/tests/dromaeo/cssquery-jquery.html) 14:41:58 INFO - 2015-12-21 14:41:58,519 DEBUG : BROWSER_OUTPUT: RSS: Main: 206979072 14:41:58 INFO - 2015-12-21 14:41:58,519 DEBUG : BROWSER_OUTPUT: 14:45:00 INFO - 2015-12-21 14:45:00,328 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44258/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44258/tests/dromaeo/cssquery-mootools.html) 14:45:00 INFO - 2015-12-21 14:45:00,895 DEBUG : BROWSER_OUTPUT: RSS: Main: 199634944 14:45:00 INFO - 2015-12-21 14:45:00,895 DEBUG : BROWSER_OUTPUT: 14:48:02 INFO - 2015-12-21 14:48:02,558 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44258/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44258/tests/dromaeo/cssquery-prototype.html) 14:48:03 INFO - 2015-12-21 14:48:03,125 DEBUG : BROWSER_OUTPUT: RSS: Main: 193970176 14:48:03 INFO - 2015-12-21 14:48:03,125 DEBUG : BROWSER_OUTPUT: 14:51:05 INFO - 2015-12-21 14:51:05,404 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44258/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44258/tests/dromaeo/cssquery-yui.html) 14:51:05 INFO - 2015-12-21 14:51:05,987 DEBUG : BROWSER_OUTPUT: RSS: Main: 182439936 14:51:05 INFO - 2015-12-21 14:51:05,987 DEBUG : BROWSER_OUTPUT: 14:54:07 INFO - 2015-12-21 14:54:07,955 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44258/tests/dromaeo/cssquery-yui.html (next: http://localhost:44258/tests/dromaeo/cssquery-dojo.html) 14:54:08 INFO - 2015-12-21 14:54:08,206 DEBUG : BROWSER_OUTPUT: RSS: Main: 233861120 14:54:08 INFO - 2015-12-21 14:54:08,206 DEBUG : BROWSER_OUTPUT: 14:54:08 INFO - 2015-12-21 14:54:08,206 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:54:08 INFO - 2015-12-21 14:54:08,207 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:54:08 INFO - 2015-12-21 14:54:08,208 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:54:08 INFO - 2015-12-21 14:54:08,208 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:54:08 INFO - 2015-12-21 14:54:08,208 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3256.5929258842643;3368.831558422078;3385.272166484207;3400.3199360127983;3400.5919289685244;5488.725563721813;5518.9724051379735;5530.668159910409;5546.306711661043;5566.749496272667;5498.120300751871;5540.085885828844;5561.4716601922855;5571.220029195916;5576.888462230753;4816.060868130716;5010.824621138261;5027.748612569357;5109.437961824215;5116.104681680709;4992.525710057557;5030.7987680492915;5031.3207716958295;5038.319826823368;5044.621653375993;5034.043531728978;5037.596992240612;5089.3638295213095;5113.360829896263;5119.462456442076;4920.434150072751;5038.899222015576;5045.41977672565;5048.596112311043;5086.491350864921;5061.114304996611;5076.568491678212;5080.568151707109;5093.236014597803;5120.462351453119;5184.144616138333;5189.6886186828915;5294.126469132589;5382.085045542267;5389.973050134763;5864.091065884794;5882.794102206402;5887.4406931341455;5951.375105613892;5988.730507127189;5901.586888917777;5908.556858235606;5913.024350982083;5917.289925209003;5921.674307913063;5371.462853714636;5413.566914646897;5469.671819690831;5517.917231241535;5545.362283337387;6015.0676645120075;6015.217423800758;6025;6086.813236197308;6093.360197179321;5825.2135961644635;5867.090600956859;5870.412958704181;5889.146073819272;5904.498117660047;5737.254156959652;5791.189233507313;5820.563457740686;5916.26046744157;5962.880742385215;5814.04068328721;5941.58408911372;5963.403659634002;5972.25346831646;5976.641401515923;5939.3763654816485;5963.493103086286;5965.701714914237;5965.731542080617;5966.880662386728;4451.265541185733;4487.775611219426;4511.887202819956;4513.187626227245;4585.060062687141;4092.0997380576227;4092.897677558085;4093.9385909211387;4101.179764047202;4125.731827431207;5554.944450555524;5591.329040515164;5598.992181407304;5599.524040456607;5607.4112218217315;5900.350961394243;5916.142159386951;5969.552283578749;6003.249593800775;6016.067509536029;5624.887502250014;5656.85857853557;5659.971700141473;5667.206591077253;5668.036433806263;4974.154393752999;5066.847994560169;5193.37679478465;5207.3751149862255;5210.76551555181;6004.099385092184;6113.419225173601;6116.445413412548;6120.257873789659;6124.873937832686;5911.408859114226;5916.142159386951;5924.585279030426;5928.911066334009;5934;5885.411458854081;6048.032314829782;6076.088586712029;6083.209182806207;6090.817275481742;5910.320313164041;5911.3201981772645;5913.881722365614;5915.438033386821;5919.970400148144;5988.850278743066;5990.7304171311525;5994.610350327215;5997.70011499432;5998.580099393001;5650.943490565041;5701.800436984686;5754.597178197486;5827.213326200908;5862.501687356623;5750.108733146369;5755.740991655469;5756.0502517084215;5758.827235182951;5832.212651292021;5649.830505084854;5652.85867853307;5654.123610840326;5661.377248502744;5661.801836935688;5677.8864422710485;5758.654480731169;5772.04761214395;5853.882922341444;5887.381824908323;5730.3410107838135;5735.512481439125;5759.1073383623925;5759.481646651821;5763.279590051244 14:54:08 INFO - 2015-12-21 14:54:08,209 DEBUG : BROWSER_OUTPUT: |1;ext.html;568.8833789073241;641.2913730327987;644.5037321262628;648.8215740671317;655.5018186178509;42597;43412.782936085314;43431.78284108575;43584.56415435845;43604;46813.53186468134;47359.76320118403;47372.0525589488;47382.289265660955;47466.28800567994;8164.1427650096775;8253.79365515861;9116.544172791351;9272.490013049279;10410.32332898363;10705.25063245573;10835.18736094792;10838.295510791773;10842.403667798268;10849.891501085007;10737.087347575465;10893.291936024172;10901;10903;10909.34543927363;10739.83890241647;10864.45677716115;10868.61959831402;10881.292715973437;10887.564497420133;10703.1437485001;10806.675799725943;10815.459227038695;10843.295185812976;10844.349339039683;42945.57054429447;43794.781026094985;43884.12231755347;43936.3409548857;44021.33967990451;3676.3750162472443;3818.293615681108;3874.9418758718643;4120.443740095108;4517.254652982254;31787.682123178703;32289;32386.6761332386;32396.6760332396;33378.83310583456;3243.6918492743152;3262.9347413051605;3355.379254837863;3377.6453472385538;3382.9830850845833;316830;317284;319185;319205;320321;64608.676956614916;64937;65102.674486627264;65112;65229.34770652328;68739.31260687429;68739.65630171917;68858;68870.31129688739;69082.30917690859;16744.330226791037;17615.735763963552;17930.641387172185;17970.371037013643;17988.820111798716;12218.083643726755;12262.570810021607;12272.631821045383;12296.631101066982;14157.716845663235;17985.50224370038;20205;21202.15191392327;21349.03929323153;21371;8087.595620218965;8177.632006559719;8196.180381961756;8314.168583141638;8338.62476188573;1060.7112358484478;1108.2519299472824;1158.5592276271816;1185.8814118588245;1232.2052276281747;30341.24146896301;30343.393132137677;30682.84658576693;30696.69303306983;31119.68880311168;1129.460424144196;1140.3386036099043;1152.6772503698978;1179.952801887932;1283.3390803736083;14796.48212312564;15630.9218453907;16001.439949601709;16246.83753162477;17163.227654755567;421884;426552;426607;427638;428155;61093.694531527944;61453.31280123207;61470;61537.38462615406;61640.691796540734;1373.6703191234033;1435.8348789889087;1447.1534152520894;1468.6915747693104;1527.4501179575343;31393;31439.371212575163;31454.213644659067;31882.36235275328;32140.03579892607;48763.512364875896;49350.25974610456;49386;49388.75305623449;49430.505694944026;292661;292866;293137;293769;293779;34969.47545786866;35883.28233435369;35963.820180898925;36142.457863131545;36316.81841590775;46730.76634616805;46791.532084678714;47417.08642960368;47744;47999.76000120117;38896;39301.60698392979;39410.80294598509;39711.40432893451;40471.19057618772;39333.40999884947;40231.396529052676;40334.39498407467;40563.594364057164;40655.7967210162;45081.774591126836;45235;45593.77203113963;46032.769836150605;46192;34607.13482162966;34643.4803477943;34764.30471390609;34880.127996800285;35249.82375088108;27579.586306205023;28259.2935176614;28317.57523637106;28374.290642734097;28650.57024144681 14:54:08 INFO - 2015-12-21 14:54:08,210 DEBUG : BROWSER_OUTPUT: |2;jquery.html;372.93660077786774;375.5343374215971;375.7613915163871;376.1048704084279;384.23920637138457;15124.848751512482;15452.227388630552;17704.291828326866;18779.2488300468;18786.06069696515;15222.467213647524;17743.46769596911;18031.72952405715;19561.608767824637;19576.216951321967;4983.103041452537;5508.9724551377185;5715.742791574389;5719.342275638313;5728.398518155596;4319.935200971972;4457.465104187502;6038.2150320458495;6220.751169953196;6232.937670623303;4965.826196083138;6130.295016073164;6133.6626485543275;6136.50907927367;6154.446099851012;5008.699478031312;5030.924536131961;5063.898722025576;5064.772085256172;5073.644844860862;4348.818967999451;4421.358902959085;4568.497465278817;4637.6289896808175;4643.117807616542;14820.62948426298;14853;15072.397104115822;15574;15587.844121558866;2137.0383327502686;2209.558088382314;2263.2531264682616;2264.9433764155865;2300;10452.111570516516;10497.4226417547;10607.734806629896;10700.785984280348;10774;1800.6959259130917;1831.5329590954354;1841.539615096226;1872.9157187926576;1888.490107670935;65486.345136548975;66378.3362166377;66547.3345266546;68267;68380.3161968379;7578.052743407075;7578.924210757932;7720.15078341382;7771.989641346702;7789.766307010798;9406;9411.764705882271;9412.15290623847;9421.764455888657;9422.905770942203;5870.412958704095;6136.2636483622255;6147.938520614826;6198.969005154945;6201.0388389799655;6210.161628180138;6261.8747625047245;6264.906026409608;6273.059041143773;6333.493320534346;3359.798412095282;3529.5940966788635;3595.694365978869;3609.9639003609627;3617.565892092913;1225.0383448992677;1226.2642414551199;1227.2820400066062;1269.4985480735058;1289.9484020639256;519.5298255079159;524.9474306905333;528.9338832645919;533.8558589180977;546.137103376664;12435.253884766942;12532.310722910144;13203.603891883067;13359.799603005962;13386.19682819034;522.2740390856712;528.1786821492616;529.4546616984512;532.760257883946;533.2694208933785;6772.966135169293;7077.646117694095;7164;7185.497015208885;7198.100237470317;627106.0226190925;643681;655183.7240813861;658087;658641;83840.58079709562;83968.16031839726;84867;84878.15121848702;86571.56714216388;575.5194412665471;583.4340689531148;585.6925114315019;600.1268154834705;606.2452246952572;12162.574309899464;12282.32447215376;12311.076669249664;12383.380830958236;12427;36335;36405.27189456249;36501.26997460089;37270.44094338641;37766.43350349692;49831.75084124701;50266.74866625643;51014.489855100976;51522.22716659328;51658.225126622376;7390.96304518474;7468.402527797654;7768.417368697484;7778.805529861799;7783.338416234684;13585.59243222705;13833.515826946008;13839.723205536035;13855.72288554203;14121.858781412055;10022.749431264278;10343.224258180517;11042.447877606248;11403.258788178742;11470.655880323604;11136.10911127124;11303.321800691985;11576.826347604625;11597.6520704379;11703.824442633537;12008.819867701817;12109.33398663082;12211.511539538318;12241.632751017483;12358.938205308916;7557.319841214317;7617.69529218825;7636.465447418627;7665.463417560717;7669.386449083949;10303.793924121326;10426.27016108865;10455.634052808115;11350.94324528372;11964.940175299416 14:54:08 INFO - 2015-12-21 14:54:08,212 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1453.178953891051;1537.0623919409159;1540.6918616276741;1849.2972670385257;1853.462495876196;7316.378107860832;7874.56689882057;8202.343812495;8214.014318281814;8225.794355141124;8018.037835459739;8115.837683246332;8118;8122.796930076751;8127.187281271885;2394.0663141374835;2425.466397392571;2425.745296743843;2426.0780903256737;2426.1265944260053;2352.0826877517698;2379.9643005354933;2381.5832229359794;2382.4163080045414;2416.1060407649106;2344.2732752846587;2344.4138965258685;2353.9646905296436;2367.4081479630095;2368.95262094758;2360.1857359211044;2364.0307473935604;2375.2992867104244;2392.569337519246;2393.126508824284;2382.4401265702545;2428.4657375377387;2442.1452491627965;2443.022790883643;2443.8655873926928;8060.798480037987;8100.311473524757;8100.513969161811;8103.635336409876;8106.067802202763;4899.387576552931;4973;4973.278874563204;4984.825531106394;4996.375453068366;3205.1506350817053;3223.0492004858625;3245.0913744151676;3245.4807230842953;3285.2443937894177;1004.2016596805557;1019.8827134879509;1036.657902892044;1042.338115296792;1043.6503771236644;11223.887761122365;11226.438678066064;11238.325700457917;11247.55009799607;11248.718782030433;4409.096135292258;4429.15845989261;4459.375687403766;4462.754548499864;4474.664400169935;9577.712668619952;9594.328397012143;9595.42427454355;9597.952010239904;9603.231741460666;4946.035523073038;4986.675866068694;4986.950130498722;4993.925091123636;5029.723365214948;4115.855945041909;4205.495340559152;4540.727556346564;4622.583967442946;4625.283081122431;3940.6059394060367;3943.3099207638547;3947.624975627311;3990.74060186087;4013.3177359848896;1192.266755945105;1192.528951064342;1198.3049831097942;1202.8255902894032;1203.7592481503734;1260.8108783682337;1263.1284413754663;1277.1379318959664;1450.5720812360169;1452.2883786944321;7618.085829700472;7876.72431464896;8063.838723225503;8114.513129212148;8134.349252059821;1230.3725100198783;1234.7283597608512;1237.0907383073434;1256.2274201366095;1259.5969289827167;6167.444929956236;6382.776602818879;6440.4847612190915;6446.967765161238;6448.290688024314;9695.078967498077;9798.461084640414;9806;9809;9815.705528834147;9087.22758565516;9701.223902087817;9774.120329170266;9774.16919561831;9804.36271642341;7700.460967732205;7755.689772409153;7758.650860711282;7765.534067956054;7774.8056298591855;7340.853182936205;7628.847423051397;7763.844723105393;7835.098963619029;7840.529568225925;8413;8456.83086338282;8547.914520854712;8572.614232359683;8600.13998600135;8642;8692.956535217283;8704.434211776468;8738.21356077956;9050.683226087056;6641.701123449359;6819.5226334158115;7110.075690160246;7195.640217989185;7300.890486642598;7864.252895975102;7866.410019248465;7905.604719764104;7922.049354077548;7923.128455869734;7271.054762881004;7437.181909989788;7466.216047314953;7544.622768861425;7548.924510755041;7359.889601655872;7439.367653749276;7459.850802984019;7496.887546686913;7532.661030253542;7465.656181887312;7491.9625401872645;7506.662200201114;7518.135414427411;7522.548647081193;6986.860262794818;7032.367086961994;7035.155781306072;7046.365827075588;7075.398591119812;7030.086088808626;7074.3633073023675;7086.220515743367;7090.255523169993;7096.0420343253 14:54:08 INFO - 2015-12-21 14:54:08,215 DEBUG : BROWSER_OUTPUT: |4;prototype.html;366.25649930640793;366.90844736907684;371.59124962541193;372.9477873097766;375.2045663194029;5958.344582095966;5963.3738457462;6003.099535069742;6014.067819487981;6027.728752206156;5691.032524470839;5750.166225897243;5770.596058275923;5873.853153671161;5894.145348924403;4585.151746926829;4603.148417542749;4614.607758340545;4615.515370886059;4616.884577885555;4609.216433206363;4610.400647915766;4617.769111544426;4618.745968971722;4620.075984803053;4591.242444996572;4595.609373203281;4596.885077873063;4601.7699115044115;4604.654650901196;4527.343535187396;4653.418322709661;4668.43978722552;4670.743109128996;4677.087967846272;4141.337386018223;4141.81361838718;4150.024744185114;4154.563770804082;4155.501339839208;5669.603127781057;5671;5673.971630141823;5676.517496012844;5682.431756824326;5411.458854114597;5419.105847535191;5420.186971954199;5421.620486565942;5425.104857698475;6161.845953851145;6239.37606239377;6258.030005349133;6266.811995640138;6271.843203919893;4526.54734526548;4551.590356867898;4552.68131230814;4557;4558.9772051139535;6371.203599550056;6433.806985790434;6438.130852334922;6439.098526206335;6443.130177425987;4655.790489427984;4730.503297153749;4736.123817093849;4752.239641657387;4755.453122890843;4803.495632958559;4807.326974223612;4817.470078291385;4842.612590992712;4848.5636292733825;5458.781648734085;5458.8908221835345;5459.727013649302;5462.153366228241;5464.890702186013;6365.427111559889;6368.904466433008;6368.936310636835;6370.299267080617;6377;1703.1143805221216;1750.212404418017;1750.3261244420735;1752.8597712182996;1757.349780581193;1127.3912087472836;1128.4470609401499;1183.4615250061202;1188.0970462448429;1207.167054732232;5972.940270597325;6007.189029481052;6009.06859436788;6021.42796434338;6027.78902738402;6432.163818703632;6434.195725534309;6435.4529864962005;6441.227052753699;6442.8389290268115;5904.616199947076;5976.581639285208;5991.760329586855;5994.790182343597;5996.16053752475;3570.785752854837;3601.4777857211084;3605.603383627799;3606.8376923038527;3609.1157666371905;6646.86706265872;6672.7330906764155;6677.532572719863;6681.265060843303;6682.365175308338;6551.115599394021;6681.131452911188;6686.4985126115735;6688;6693.196816382066;6689.732410703615;6698.196216454056;6700.095487109275;6707.564008339442;6707.6981535831;6471.902921456088;6503.414692677682;6508.576942498722;6511.088447617432;6516.706748196438;6298.811035668938;6355.300916899045;6418.326075761977;6419.037144428373;6421.903671444838;6689.364510371507;6699.564528305645;6699.76550820719;6701.195856497252;6702.7654032110595;4794.59245964083;4796.424429068534;4801.1117943180625;4801.231802911518;4801.5438533339275;6459.709313080829;6490.610563366213;6501.9674901625185;6505.21937367519;6520.510961677988;6218.22272215973;6335.208098987627;6336.17629708135;6356.77751278703;6357.586756860789;6273.749050037947;6304.84237894038;6338.936610633835;6344.71448784815;6346.746130154742;6089.117078023573;6238.064290356483;6243.406876346739;6245.687715614292;6247.812565623039;6209.944309467311;6365.490760739222;6383.010633351838;6390.872182556416;6396.712147953446;6209.875802484015;6211.068339749074;6211.130441738251;6222.377762223922;6240.095186197885 14:54:08 INFO - 2015-12-21 14:54:08,217 DEBUG : BROWSER_OUTPUT: |5;yui.html;809.0614886731393;821.1829229916234;849.6261644876254;864.5936409887358;871.7036207689388;14248.145111293317;14545.563633090998;14545.854541454582;14561.854381456182;14588.635284117903;14137.717245655082;14208.431662733477;14209.07641003334;14245.14529128253;14263.572092837205;768.642581199742;782.2803021220462;913.6482454255093;917.4907926101012;941.336357867705;923.5705396990398;928.5264515097282;932.5523748600676;935.6117211357279;936.9812603747955;817.9018517777845;977.1352353167426;980.1178938954962;980.3284749946274;982.5431174503855;822.3421262989614;944.1266828183936;962.0667952086535;963.3112324687881;964.0841200859212;724.9383802376805;725.0538047847557;725.3725527418745;725.5864157430267;725.7060890339421;13072.738545229136;13082.934585327013;13150;13161.473541058345;13184.472621095145;11789.646310610695;12484.375781210994;12565.497380104785;12584.4337004835;12727.554535591209;10119.89880101197;10273.434961077137;10314.12329951955;10335.069843714102;10349.534270957825;3532.5054492371087;3579.230465449915;3586.659267369596;3590.0486371111674;3607.4588811678195;49770.50229497695;49875.25187122196;53006.20490692681;53056.73471632617;53112.46887531114;9494.098060684224;9525.095115964112;9633.229341652792;9669.516524173763;9680.322377433513;20235;20288.797112028988;20320.28878989228;20406.285779997925;20425.2851150212;7144.535605185646;7191.2449192834;7208.24313447091;7321.853562928712;7322.707091716272;4428.756418397019;4582.610478109332;4585.747783871919;4606.101810146989;4648.5119062498625;3047.360054388603;3085.3212293295437;3094.3501864608684;3095.6440009399207;3100.5814215080677;458.1044058864911;459.3064472646328;459.85284708892834;463.1038939651785;463.7426228443179;620.2402057479552;645.1097485470021;651.9087327774115;664.6510581944518;669.2136739331363;9245.3528253023;9301.860472092923;9379.296552758571;9434.009429009993;9492.857607135898;468.2741750287041;558.2770312445393;596.931352894414;640.4876099120778;653.2748648999607;4150.211459822684;4270.103278311527;4271.765052922119;4337.609615134653;4344.391785150082;63331.36668633255;64082.35917640857;64813.67593162004;66883.66558167178;67013.32986670168;53699.46300537023;54071.72964135154;55705.16442253369;55877.44122558722;56297.15554266689;49992.50007499951;51394;51715.482845171064;52191.47808521866;52440.21339679908;8055.556944368116;8274.089850116363;8452.873206902024;8488.363372746946;8741.78145546341;38062.23875522529;38460.80769596134;39037.21925561416;39059.41410878896;39128.804355978034;44426.33360499531;46354.536454635025;49147.508524914294;49404.50595494143;49923.25115123349;7702.229777022253;7791.142974272939;7858.13560508355;7882.172371900868;8010.759677209693;11829.76340473203;11848.407579621156;11952.34262115592;11971.521139154336;12355.196912200678;11115;11120;11245.873153779323;11270.211085223955;11362.886371136183;10872;11101.278416903198;11112.722181945515;11178.161637877354;11554.075673945896;10469.528871200662;11630.244034137753;11640.592579260025;11799.882001179878;11904.880951190376;9787.265955053257;9921.900780992097;9963.900360996588;10007.199424046205;10271.794564108526;8971;9152.908470915205;9161.633534658538;9273.165415112673;9671.951640241754 14:54:08 INFO - 2015-12-21 14:54:08,217 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:54:08 INFO - 2015-12-21 14:54:08,217 DEBUG : BROWSER_OUTPUT: __start_cc_report 14:54:08 INFO - 2015-12-21 14:54:08,218 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,832 14:54:08 INFO - 2015-12-21 14:54:08,218 DEBUG : BROWSER_OUTPUT: __end_cc_report 14:54:08 INFO - 2015-12-21 14:54:08,218 DEBUG : BROWSER_OUTPUT: __startTimestamp1450738448206__endTimestamp 14:54:08 INFO - 2015-12-21 14:54:08,218 DEBUG : BROWSER_OUTPUT: 14:54:08 INFO - 2015-12-21 14:54:08,218 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:54:08 INFO - 2015-12-21 14:54:08,218 DEBUG : BROWSER_OUTPUT: Number of tests: 6 14:54:08 INFO - 2015-12-21 14:54:08,218 DEBUG : BROWSER_OUTPUT: 14:54:08 INFO - 2015-12-21 14:54:08,218 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5501.62 Median:5701.80 stddev:602.26 (10.6%) stddev-sans-first:577.78 14:54:08 INFO - 2015-12-21 14:54:08,219 DEBUG : BROWSER_OUTPUT: Values: 3256.6 3368.8 3385.3 3400.3 3400.6 5488.7 5519.0 5530.7 5546.3 5566.7 5498.1 5540.1 5561.5 5571.2 5576.9 4816.1 5010.8 5027.7 5109.4 5116.1 4992.5 5030.8 5031.3 5038.3 5044.6 5034.0 5037.6 5089.4 5113.4 5119.5 4920.4 5038.9 5045.4 5048.6 5086.5 5061.1 5076.6 5080.6 5093.2 5120.5 5184.1 5189.7 5294.1 5382.1 5390.0 5864.1 5882.8 5887.4 5951.4 5988.7 5901.6 5908.6 5913.0 5917.3 5921.7 5371.5 5413.6 5469.7 5517.9 5545.4 6015.1 6015.2 6025.0 6086.8 6093.4 5825.2 5867.1 5870.4 5889.1 5904.5 5737.3 5791.2 5820.6 5916.3 5962.9 5814.0 5941.6 5963.4 5972.3 5976.6 5939.4 5963.5 5965.7 5965.7 5966.9 4451.3 4487.8 4511.9 4513.2 4585.1 4092.1 4092.9 4093.9 4101.2 4125.7 5554.9 5591.3 5599.0 5599.5 5607.4 5900.4 5916.1 5969.6 6003.2 6016.1 5624.9 5656.9 5660.0 5667.2 5668.0 4974.2 5066.8 5193.4 5207.4 5210.8 6004.1 6113.4 6116.4 6120.3 6124.9 5911.4 5916.1 5924.6 5928.9 5934.0 5885.4 6048.0 6076.1 6083.2 6090.8 5910.3 5911.3 5913.9 5915.4 5920.0 5988.9 5990.7 5994.6 5997.7 5998.6 5650.9 5701.8 5754.6 5827.2 5862.5 5750.1 5755.7 5756.1 5758.8 5832.2 5649.8 5652.9 5654.1 5661.4 5661.8 5677.9 5758.7 5772.0 5853.9 5887.4 5730.3 5735.5 5759.1 5759.5 5763.3 14:54:08 INFO - 2015-12-21 14:54:08,219 DEBUG : BROWSER_OUTPUT: 14:54:08 INFO - 2015-12-21 14:54:08,219 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:53396.76 Median:18995.06 stddev:92035.29 (484.5%) stddev-sans-first:92208.00 14:54:08 INFO - 2015-12-21 14:54:08,220 DEBUG : BROWSER_OUTPUT: Values: 568.9 641.3 644.5 648.8 655.5 42597.0 43412.8 43431.8 43584.6 43604.0 46813.5 47359.8 47372.1 47382.3 47466.3 8164.1 8253.8 9116.5 9272.5 10410.3 10705.3 10835.2 10838.3 10842.4 10849.9 10737.1 10893.3 10901.0 10903.0 10909.3 10739.8 10864.5 10868.6 10881.3 10887.6 10703.1 10806.7 10815.5 10843.3 10844.3 42945.6 43794.8 43884.1 43936.3 44021.3 3676.4 3818.3 3874.9 4120.4 4517.3 31787.7 32289.0 32386.7 32396.7 33378.8 3243.7 3262.9 3355.4 3377.6 3383.0 316830.0 317284.0 319185.0 319205.0 320321.0 64608.7 64937.0 65102.7 65112.0 65229.3 68739.3 68739.7 68858.0 68870.3 69082.3 16744.3 17615.7 17930.6 17970.4 17988.8 12218.1 12262.6 12272.6 12296.6 14157.7 17985.5 20205.0 21202.2 21349.0 21371.0 8087.6 8177.6 8196.2 8314.2 8338.6 1060.7 1108.3 1158.6 1185.9 1232.2 30341.2 30343.4 30682.8 30696.7 31119.7 1129.5 1140.3 1152.7 1180.0 1283.3 14796.5 15630.9 16001.4 16246.8 17163.2 421884.0 426552.0 426607.0 427638.0 428155.0 61093.7 61453.3 61470.0 61537.4 61640.7 1373.7 1435.8 1447.2 1468.7 1527.5 31393.0 31439.4 31454.2 31882.4 32140.0 48763.5 49350.3 49386.0 49388.8 49430.5 292661.0 292866.0 293137.0 293769.0 293779.0 34969.5 35883.3 35963.8 36142.5 36316.8 46730.8 46791.5 47417.1 47744.0 47999.8 38896.0 39301.6 39410.8 39711.4 40471.2 39333.4 40231.4 40334.4 40563.6 40655.8 45081.8 45235.0 45593.8 46032.8 46192.0 34607.1 34643.5 34764.3 34880.1 35249.8 27579.6 28259.3 28317.6 28374.3 28650.6 14:54:08 INFO - 2015-12-21 14:54:08,220 DEBUG : BROWSER_OUTPUT: 14:54:08 INFO - 2015-12-21 14:54:08,220 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:31189.32 Median:4640.37 stddev:106219.48 (2289.0%) stddev-sans-first:106492.25 14:54:08 INFO - 2015-12-21 14:54:08,222 DEBUG : BROWSER_OUTPUT: Values: 372.9 375.5 375.8 376.1 384.2 15124.8 15452.2 17704.3 18779.2 18786.1 15222.5 17743.5 18031.7 19561.6 19576.2 4983.1 5509.0 5715.7 5719.3 5728.4 4319.9 4457.5 6038.2 6220.8 6232.9 4965.8 6130.3 6133.7 6136.5 6154.4 5008.7 5030.9 5063.9 5064.8 5073.6 4348.8 4421.4 4568.5 4637.6 4643.1 14820.6 14853.0 15072.4 15574.0 15587.8 2137.0 2209.6 2263.3 2264.9 2300.0 10452.1 10497.4 10607.7 10700.8 10774.0 1800.7 1831.5 1841.5 1872.9 1888.5 65486.3 66378.3 66547.3 68267.0 68380.3 7578.1 7578.9 7720.2 7772.0 7789.8 9406.0 9411.8 9412.2 9421.8 9422.9 5870.4 6136.3 6147.9 6199.0 6201.0 6210.2 6261.9 6264.9 6273.1 6333.5 3359.8 3529.6 3595.7 3610.0 3617.6 1225.0 1226.3 1227.3 1269.5 1289.9 519.5 524.9 528.9 533.9 546.1 12435.3 12532.3 13203.6 13359.8 13386.2 522.3 528.2 529.5 532.8 533.3 6773.0 7077.6 7164.0 7185.5 7198.1 627106.0 643681.0 655183.7 658087.0 658641.0 83840.6 83968.2 84867.0 84878.2 86571.6 575.5 583.4 585.7 600.1 606.2 12162.6 12282.3 12311.1 12383.4 12427.0 36335.0 36405.3 36501.3 37270.4 37766.4 49831.8 50266.7 51014.5 51522.2 51658.2 7391.0 7468.4 7768.4 7778.8 7783.3 13585.6 13833.5 13839.7 13855.7 14121.9 10022.7 10343.2 11042.4 11403.3 11470.7 11136.1 11303.3 11576.8 11597.7 11703.8 12008.8 12109.3 12211.5 12241.6 12358.9 7557.3 7617.7 7636.5 7665.5 7669.4 10303.8 10426.3 10455.6 11350.9 11964.9 14:54:08 INFO - 2015-12-21 14:54:08,222 DEBUG : BROWSER_OUTPUT: 14:54:08 INFO - 2015-12-21 14:54:08,222 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5759.59 Median:6730.61 stddev:2947.27 (43.8%) stddev-sans-first:2937.76 14:54:08 INFO - 2015-12-21 14:54:08,222 DEBUG : BROWSER_OUTPUT: Values: 1453.2 1537.1 1540.7 1849.3 1853.5 7316.4 7874.6 8202.3 8214.0 8225.8 8018.0 8115.8 8118.0 8122.8 8127.2 2394.1 2425.5 2425.7 2426.1 2426.1 2352.1 2380.0 2381.6 2382.4 2416.1 2344.3 2344.4 2354.0 2367.4 2369.0 2360.2 2364.0 2375.3 2392.6 2393.1 2382.4 2428.5 2442.1 2443.0 2443.9 8060.8 8100.3 8100.5 8103.6 8106.1 4899.4 4973.0 4973.3 4984.8 4996.4 3205.2 3223.0 3245.1 3245.5 3285.2 1004.2 1019.9 1036.7 1042.3 1043.7 11223.9 11226.4 11238.3 11247.6 11248.7 4409.1 4429.2 4459.4 4462.8 4474.7 9577.7 9594.3 9595.4 9598.0 9603.2 4946.0 4986.7 4987.0 4993.9 5029.7 4115.9 4205.5 4540.7 4622.6 4625.3 3940.6 3943.3 3947.6 3990.7 4013.3 1192.3 1192.5 1198.3 1202.8 1203.8 1260.8 1263.1 1277.1 1450.6 1452.3 7618.1 7876.7 8063.8 8114.5 8134.3 1230.4 1234.7 1237.1 1256.2 1259.6 6167.4 6382.8 6440.5 6447.0 6448.3 9695.1 9798.5 9806.0 9809.0 9815.7 9087.2 9701.2 9774.1 9774.2 9804.4 7700.5 7755.7 7758.7 7765.5 7774.8 7340.9 7628.8 7763.8 7835.1 7840.5 8413.0 8456.8 8547.9 8572.6 8600.1 8642.0 8693.0 8704.4 8738.2 9050.7 6641.7 6819.5 7110.1 7195.6 7300.9 7864.3 7866.4 7905.6 7922.0 7923.1 7271.1 7437.2 7466.2 7544.6 7548.9 7359.9 7439.4 7459.9 7496.9 7532.7 7465.7 7492.0 7506.7 7518.1 7522.5 6986.9 7032.4 7035.2 7046.4 7075.4 7030.1 7074.4 7086.2 7090.3 7096.0 14:54:08 INFO - 2015-12-21 14:54:08,222 DEBUG : BROWSER_OUTPUT: 14:54:08 INFO - 2015-12-21 14:54:08,222 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5325.50 Median:5993.28 stddev:1536.58 (25.6%) stddev-sans-first:1495.13 14:54:08 INFO - 2015-12-21 14:54:08,222 DEBUG : BROWSER_OUTPUT: Values: 366.3 366.9 371.6 372.9 375.2 5958.3 5963.4 6003.1 6014.1 6027.7 5691.0 5750.2 5770.6 5873.9 5894.1 4585.2 4603.1 4614.6 4615.5 4616.9 4609.2 4610.4 4617.8 4618.7 4620.1 4591.2 4595.6 4596.9 4601.8 4604.7 4527.3 4653.4 4668.4 4670.7 4677.1 4141.3 4141.8 4150.0 4154.6 4155.5 5669.6 5671.0 5674.0 5676.5 5682.4 5411.5 5419.1 5420.2 5421.6 5425.1 6161.8 6239.4 6258.0 6266.8 6271.8 4526.5 4551.6 4552.7 4557.0 4559.0 6371.2 6433.8 6438.1 6439.1 6443.1 4655.8 4730.5 4736.1 4752.2 4755.5 4803.5 4807.3 4817.5 4842.6 4848.6 5458.8 5458.9 5459.7 5462.2 5464.9 6365.4 6368.9 6368.9 6370.3 6377.0 1703.1 1750.2 1750.3 1752.9 1757.3 1127.4 1128.4 1183.5 1188.1 1207.2 5972.9 6007.2 6009.1 6021.4 6027.8 6432.2 6434.2 6435.5 6441.2 6442.8 5904.6 5976.6 5991.8 5994.8 5996.2 3570.8 3601.5 3605.6 3606.8 3609.1 6646.9 6672.7 6677.5 6681.3 6682.4 6551.1 6681.1 6686.5 6688.0 6693.2 6689.7 6698.2 6700.1 6707.6 6707.7 6471.9 6503.4 6508.6 6511.1 6516.7 6298.8 6355.3 6418.3 6419.0 6421.9 6689.4 6699.6 6699.8 6701.2 6702.8 4794.6 4796.4 4801.1 4801.2 4801.5 6459.7 6490.6 6502.0 6505.2 6520.5 6218.2 6335.2 6336.2 6356.8 6357.6 6273.7 6304.8 6338.9 6344.7 6346.7 6089.1 6238.1 6243.4 6245.7 6247.8 6209.9 6365.5 6383.0 6390.9 6396.7 6209.9 6211.1 6211.1 6222.4 6240.1 14:54:08 INFO - 2015-12-21 14:54:08,222 DEBUG : BROWSER_OUTPUT: 14:54:08 INFO - 2015-12-21 14:54:08,223 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14587.85 Median:50693.25 stddev:17666.99 (34.9%) stddev-sans-first:17686.25 14:54:08 INFO - 2015-12-21 14:54:08,223 DEBUG : BROWSER_OUTPUT: Values: 809.1 821.2 849.6 864.6 871.7 14248.1 14545.6 14545.9 14561.9 14588.6 14137.7 14208.4 14209.1 14245.1 14263.6 768.6 782.3 913.6 917.5 941.3 923.6 928.5 932.6 935.6 937.0 817.9 977.1 980.1 980.3 982.5 822.3 944.1 962.1 963.3 964.1 724.9 725.1 725.4 725.6 725.7 13072.7 13082.9 13150.0 13161.5 13184.5 11789.6 12484.4 12565.5 12584.4 12727.6 10119.9 10273.4 10314.1 10335.1 10349.5 3532.5 3579.2 3586.7 3590.0 3607.5 49770.5 49875.3 53006.2 53056.7 53112.5 9494.1 9525.1 9633.2 9669.5 9680.3 20235.0 20288.8 20320.3 20406.3 20425.3 7144.5 7191.2 7208.2 7321.9 7322.7 4428.8 4582.6 4585.7 4606.1 4648.5 3047.4 3085.3 3094.4 3095.6 3100.6 458.1 459.3 459.9 463.1 463.7 620.2 645.1 651.9 664.7 669.2 9245.4 9301.9 9379.3 9434.0 9492.9 468.3 558.3 596.9 640.5 653.3 4150.2 4270.1 4271.8 4337.6 4344.4 63331.4 64082.4 64813.7 66883.7 67013.3 53699.5 54071.7 55705.2 55877.4 56297.2 49992.5 51394.0 51715.5 52191.5 52440.2 8055.6 8274.1 8452.9 8488.4 8741.8 38062.2 38460.8 39037.2 39059.4 39128.8 44426.3 46354.5 49147.5 49404.5 49923.3 7702.2 7791.1 7858.1 7882.2 8010.8 11829.8 11848.4 11952.3 11971.5 12355.2 11115.0 11120.0 11245.9 11270.2 11362.9 10872.0 11101.3 11112.7 11178.2 11554.1 10469.5 11630.2 11640.6 11799.9 11904.9 9787.3 9921.9 9963.9 10007.2 10271.8 8971.0 9152.9 9161.6 9273.2 9672.0 14:54:08 INFO - 2015-12-21 14:54:08,223 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:54:08 INFO - 2015-12-21 14:54:08,223 DEBUG : BROWSER_OUTPUT: 14:54:08 INFO - 2015-12-21 14:54:08,766 INFO : Browser exited with error code: 0 14:54:08 INFO - 2015-12-21 14:54:08,789 INFO : Completed test dromaeo_css (00:18:29) 14:54:08 INFO - 2015-12-21 14:54:08,789 INFO : Starting test kraken 14:54:08 INFO - 2015-12-21 14:54:08,789 DEBUG : operating with platform_type : linux_ 14:54:08 INFO - 2015-12-21 14:54:08,789 INFO : Initialising browser for kraken test... 14:54:08 INFO - 2015-12-21 14:54:08,796 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpGx31w4/profile http://localhost:44258/getInfo.html 14:54:12 INFO - 2015-12-21 14:54:12,719 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:54:12 INFO - 2015-12-21 14:54:12,720 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:54:12 INFO - 2015-12-21 14:54:12,720 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 14:54:12 INFO - 2015-12-21 14:54:12,720 DEBUG : BROWSER_OUTPUT: __metrics 14:54:12 INFO - 2015-12-21 14:54:12,836 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:54:14 INFO - 2015-12-21 14:54:14,218 INFO : Browser initialized. 14:54:14 INFO - 2015-12-21 14:54:14,218 INFO : Running cycle 1/1 for kraken test... 14:54:14 INFO - 2015-12-21 14:54:14,219 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpGx31w4/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:54:25 INFO - 2015-12-21 14:54:25,723 DEBUG : BROWSER_OUTPUT: RSS: Main: 128581632 14:54:25 INFO - 2015-12-21 14:54:25,723 DEBUG : BROWSER_OUTPUT: 14:54:28 INFO - 2015-12-21 14:54:28,138 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44258/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44258/tests/kraken/driver.html?testName=audio-beat-detection) 14:54:28 INFO - 2015-12-21 14:54:28,707 DEBUG : BROWSER_OUTPUT: RSS: Main: 161869824 14:54:28 INFO - 2015-12-21 14:54:28,708 DEBUG : BROWSER_OUTPUT: 14:54:31 INFO - 2015-12-21 14:54:31,245 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44258/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44258/tests/kraken/driver.html?testName=audio-dft) 14:54:31 INFO - 2015-12-21 14:54:31,814 DEBUG : BROWSER_OUTPUT: RSS: Main: 159428608 14:54:31 INFO - 2015-12-21 14:54:31,815 DEBUG : BROWSER_OUTPUT: 14:54:34 INFO - 2015-12-21 14:54:34,580 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44258/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44258/tests/kraken/driver.html?testName=audio-fft) 14:54:35 INFO - 2015-12-21 14:54:35,146 DEBUG : BROWSER_OUTPUT: RSS: Main: 156643328 14:54:35 INFO - 2015-12-21 14:54:35,146 DEBUG : BROWSER_OUTPUT: 14:54:37 INFO - 2015-12-21 14:54:37,102 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44258/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44258/tests/kraken/driver.html?testName=audio-oscillator) 14:54:37 INFO - 2015-12-21 14:54:37,669 DEBUG : BROWSER_OUTPUT: RSS: Main: 155971584 14:54:37 INFO - 2015-12-21 14:54:37,669 DEBUG : BROWSER_OUTPUT: 14:54:39 INFO - 2015-12-21 14:54:39,805 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44258/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44258/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:54:40 INFO - 2015-12-21 14:54:40,366 DEBUG : BROWSER_OUTPUT: RSS: Main: 154152960 14:54:40 INFO - 2015-12-21 14:54:40,366 DEBUG : BROWSER_OUTPUT: 14:54:43 INFO - 2015-12-21 14:54:43,250 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44258/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44258/tests/kraken/driver.html?testName=imaging-darkroom) 14:54:43 INFO - 2015-12-21 14:54:43,816 DEBUG : BROWSER_OUTPUT: RSS: Main: 154271744 14:54:43 INFO - 2015-12-21 14:54:43,816 DEBUG : BROWSER_OUTPUT: 14:54:47 INFO - 2015-12-21 14:54:47,177 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44258/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44258/tests/kraken/driver.html?testName=imaging-desaturate) 14:54:47 INFO - 2015-12-21 14:54:47,744 DEBUG : BROWSER_OUTPUT: RSS: Main: 156082176 14:54:47 INFO - 2015-12-21 14:54:47,744 DEBUG : BROWSER_OUTPUT: 14:54:50 INFO - 2015-12-21 14:54:50,466 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44258/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44258/tests/kraken/driver.html?testName=json-parse-financial) 14:54:51 INFO - 2015-12-21 14:54:51,039 DEBUG : BROWSER_OUTPUT: RSS: Main: 155459584 14:54:51 INFO - 2015-12-21 14:54:51,039 DEBUG : BROWSER_OUTPUT: 14:54:52 INFO - 2015-12-21 14:54:52,571 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44258/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44258/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:54:53 INFO - 2015-12-21 14:54:53,135 DEBUG : BROWSER_OUTPUT: RSS: Main: 157396992 14:54:53 INFO - 2015-12-21 14:54:53,135 DEBUG : BROWSER_OUTPUT: 14:54:54 INFO - 2015-12-21 14:54:54,891 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44258/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44258/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:54:55 INFO - 2015-12-21 14:54:55,485 DEBUG : BROWSER_OUTPUT: RSS: Main: 156471296 14:54:55 INFO - 2015-12-21 14:54:55,486 DEBUG : BROWSER_OUTPUT: 14:54:57 INFO - 2015-12-21 14:54:57,438 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44258/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44258/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:54:58 INFO - 2015-12-21 14:54:58,004 DEBUG : BROWSER_OUTPUT: RSS: Main: 163143680 14:54:58 INFO - 2015-12-21 14:54:58,005 DEBUG : BROWSER_OUTPUT: 14:55:00 INFO - 2015-12-21 14:55:00,302 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44258/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44258/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:55:00 INFO - 2015-12-21 14:55:00,883 DEBUG : BROWSER_OUTPUT: RSS: Main: 167190528 14:55:00 INFO - 2015-12-21 14:55:00,883 DEBUG : BROWSER_OUTPUT: 14:55:03 INFO - 2015-12-21 14:55:03,289 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44258/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44258/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:55:03 INFO - 2015-12-21 14:55:03,851 DEBUG : BROWSER_OUTPUT: RSS: Main: 164806656 14:55:03 INFO - 2015-12-21 14:55:03,851 DEBUG : BROWSER_OUTPUT: 14:55:05 INFO - 2015-12-21 14:55:05,451 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44258/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44258/tests/kraken/driver.html?testName=ai-astar) 14:55:05 INFO - 2015-12-21 14:55:05,701 DEBUG : BROWSER_OUTPUT: RSS: Main: 223256576 14:55:05 INFO - 2015-12-21 14:55:05,702 DEBUG : BROWSER_OUTPUT: 14:55:05 INFO - 2015-12-21 14:55:05,703 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:55:05 INFO - 2015-12-21 14:55:05,703 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:55:05 INFO - 2015-12-21 14:55:05,703 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:55:05 INFO - 2015-12-21 14:55:05,704 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:55:05 INFO - 2015-12-21 14:55:05,704 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;110;104;110;109;110;101;109;97;108 14:55:05 INFO - 2015-12-21 14:55:05,704 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;146;122;143;164;122;145;155;122;176;122 14:55:05 INFO - 2015-12-21 14:55:05,704 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;160;159;159;162;160;159;161;161;159 14:55:05 INFO - 2015-12-21 14:55:05,704 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;71;72;147;75;72;70;71;147;71 14:55:05 INFO - 2015-12-21 14:55:05,704 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;90;89;134;88;91;89;129;89;89;135 14:55:05 INFO - 2015-12-21 14:55:05,705 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;109;110;110;109;109;110;109 14:55:05 INFO - 2015-12-21 14:55:05,705 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;147;146;145;145;147;145;146;146;146 14:55:05 INFO - 2015-12-21 14:55:05,705 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;96;96;96;96;95;96;95;95 14:55:05 INFO - 2015-12-21 14:55:05,705 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;55;66;55;57;54;58;56;57;54;54 14:55:05 INFO - 2015-12-21 14:55:05,705 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;63;63;63;64;71;63;63;63;62;63 14:55:05 INFO - 2015-12-21 14:55:05,705 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;76;78;76;78;77;78;75;77;85;77 14:55:05 INFO - 2015-12-21 14:55:05,706 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;112;114;108;114;116;108;113;113;109;111 14:55:05 INFO - 2015-12-21 14:55:05,706 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;136;134;137;138;132;128;136;145;133;133 14:55:05 INFO - 2015-12-21 14:55:05,706 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;62;61;62;61;62;61;60;61;61;61 14:55:05 INFO - 2015-12-21 14:55:05,706 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:55:05 INFO - 2015-12-21 14:55:05,706 DEBUG : BROWSER_OUTPUT: __start_cc_report 14:55:05 INFO - 2015-12-21 14:55:05,708 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,890 14:55:05 INFO - 2015-12-21 14:55:05,708 DEBUG : BROWSER_OUTPUT: __end_cc_report 14:55:05 INFO - 2015-12-21 14:55:05,708 DEBUG : BROWSER_OUTPUT: __startTimestamp1450738505702__endTimestamp 14:55:05 INFO - 2015-12-21 14:55:05,708 DEBUG : BROWSER_OUTPUT: 14:55:05 INFO - 2015-12-21 14:55:05,709 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:55:05 INFO - 2015-12-21 14:55:05,710 DEBUG : BROWSER_OUTPUT: Number of tests: 14 14:55:05 INFO - 2015-12-21 14:55:05,710 DEBUG : BROWSER_OUTPUT: 14:55:05 INFO - 2015-12-21 14:55:05,710 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:106.60 Median:109.50 stddev:4.48 (4.1%) stddev-sans-first:4.72 14:55:05 INFO - 2015-12-21 14:55:05,710 DEBUG : BROWSER_OUTPUT: Values: 108.0 110.0 104.0 110.0 109.0 110.0 101.0 109.0 97.0 108.0 14:55:05 INFO - 2015-12-21 14:55:05,710 DEBUG : BROWSER_OUTPUT: 14:55:05 INFO - 2015-12-21 14:55:05,710 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:141.70 Median:145.50 stddev:19.53 (13.4%) stddev-sans-first:20.66 14:55:05 INFO - 2015-12-21 14:55:05,710 DEBUG : BROWSER_OUTPUT: Values: 146.0 122.0 143.0 164.0 122.0 145.0 155.0 122.0 176.0 122.0 14:55:05 INFO - 2015-12-21 14:55:05,710 DEBUG : BROWSER_OUTPUT: 14:55:05 INFO - 2015-12-21 14:55:05,710 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.10 Median:160.50 stddev:1.10 (0.7%) stddev-sans-first:1.12 14:55:05 INFO - 2015-12-21 14:55:05,711 DEBUG : BROWSER_OUTPUT: Values: 161.0 160.0 159.0 159.0 162.0 160.0 159.0 161.0 161.0 159.0 14:55:05 INFO - 2015-12-21 14:55:05,711 DEBUG : BROWSER_OUTPUT: 14:55:05 INFO - 2015-12-21 14:55:05,711 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:86.80 Median:71.50 stddev:31.76 (44.4%) stddev-sans-first:33.23 14:55:05 INFO - 2015-12-21 14:55:05,712 DEBUG : BROWSER_OUTPUT: Values: 72.0 71.0 72.0 147.0 75.0 72.0 70.0 71.0 147.0 71.0 14:55:05 INFO - 2015-12-21 14:55:05,712 DEBUG : BROWSER_OUTPUT: 14:55:05 INFO - 2015-12-21 14:55:05,712 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:102.30 Median:89.00 stddev:21.02 (23.6%) stddev-sans-first:21.82 14:55:05 INFO - 2015-12-21 14:55:05,712 DEBUG : BROWSER_OUTPUT: Values: 90.0 89.0 134.0 88.0 91.0 89.0 129.0 89.0 89.0 135.0 14:55:05 INFO - 2015-12-21 14:55:05,712 DEBUG : BROWSER_OUTPUT: 14:55:05 INFO - 2015-12-21 14:55:05,713 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 14:55:05 INFO - 2015-12-21 14:55:05,713 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 109.0 110.0 110.0 109.0 109.0 110.0 109.0 14:55:05 INFO - 2015-12-21 14:55:05,713 DEBUG : BROWSER_OUTPUT: 14:55:05 INFO - 2015-12-21 14:55:05,713 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.78 14:55:05 INFO - 2015-12-21 14:55:05,713 DEBUG : BROWSER_OUTPUT: Values: 147.0 147.0 146.0 145.0 145.0 147.0 145.0 146.0 146.0 146.0 14:55:05 INFO - 2015-12-21 14:55:05,713 DEBUG : BROWSER_OUTPUT: 14:55:05 INFO - 2015-12-21 14:55:05,713 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 14:55:05 INFO - 2015-12-21 14:55:05,713 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 96.0 96.0 96.0 96.0 95.0 96.0 95.0 95.0 14:55:05 INFO - 2015-12-21 14:55:05,713 DEBUG : BROWSER_OUTPUT: 14:55:05 INFO - 2015-12-21 14:55:05,713 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:56.60 Median:56.50 stddev:3.60 (6.4%) stddev-sans-first:3.77 14:55:05 INFO - 2015-12-21 14:55:05,713 DEBUG : BROWSER_OUTPUT: Values: 55.0 66.0 55.0 57.0 54.0 58.0 56.0 57.0 54.0 54.0 14:55:05 INFO - 2015-12-21 14:55:05,713 DEBUG : BROWSER_OUTPUT: 14:55:05 INFO - 2015-12-21 14:55:05,713 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:63.80 Median:63.00 stddev:2.57 (4.1%) stddev-sans-first:2.71 14:55:05 INFO - 2015-12-21 14:55:05,713 DEBUG : BROWSER_OUTPUT: Values: 63.0 63.0 63.0 64.0 71.0 63.0 63.0 63.0 62.0 63.0 14:55:05 INFO - 2015-12-21 14:55:05,713 DEBUG : BROWSER_OUTPUT: 14:55:05 INFO - 2015-12-21 14:55:05,714 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:77.70 Median:77.50 stddev:2.75 (3.5%) stddev-sans-first:2.85 14:55:05 INFO - 2015-12-21 14:55:05,714 DEBUG : BROWSER_OUTPUT: Values: 76.0 78.0 76.0 78.0 77.0 78.0 75.0 77.0 85.0 77.0 14:55:05 INFO - 2015-12-21 14:55:05,714 DEBUG : BROWSER_OUTPUT: 14:55:05 INFO - 2015-12-21 14:55:05,714 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:111.80 Median:113.00 stddev:2.74 (2.4%) stddev-sans-first:2.91 14:55:05 INFO - 2015-12-21 14:55:05,714 DEBUG : BROWSER_OUTPUT: Values: 112.0 114.0 108.0 114.0 116.0 108.0 113.0 113.0 109.0 111.0 14:55:05 INFO - 2015-12-21 14:55:05,714 DEBUG : BROWSER_OUTPUT: 14:55:05 INFO - 2015-12-21 14:55:05,714 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:135.20 Median:136.00 stddev:4.49 (3.3%) stddev-sans-first:4.76 14:55:05 INFO - 2015-12-21 14:55:05,714 DEBUG : BROWSER_OUTPUT: Values: 136.0 134.0 137.0 138.0 132.0 128.0 136.0 145.0 133.0 133.0 14:55:05 INFO - 2015-12-21 14:55:05,714 DEBUG : BROWSER_OUTPUT: 14:55:05 INFO - 2015-12-21 14:55:05,714 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.20 Median:61.00 stddev:0.63 (1.0%) stddev-sans-first:0.60 14:55:05 INFO - 2015-12-21 14:55:05,714 DEBUG : BROWSER_OUTPUT: Values: 62.0 61.0 62.0 61.0 62.0 61.0 60.0 61.0 61.0 61.0 14:55:05 INFO - 2015-12-21 14:55:05,714 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:55:05 INFO - 2015-12-21 14:55:05,714 DEBUG : BROWSER_OUTPUT: 14:55:06 INFO - 2015-12-21 14:55:06,358 INFO : Browser exited with error code: 0 14:55:06 INFO - 2015-12-21 14:55:06,408 INFO : Completed test kraken (00:00:57) 14:55:06 INFO - 2015-12-21 14:55:06,408 INFO : Starting test v8_7 14:55:06 INFO - 2015-12-21 14:55:06,408 DEBUG : operating with platform_type : linux_ 14:55:06 INFO - 2015-12-21 14:55:06,408 INFO : Initialising browser for v8_7 test... 14:55:06 INFO - 2015-12-21 14:55:06,415 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJbHOfQ/profile http://localhost:44258/getInfo.html 14:55:10 INFO - 2015-12-21 14:55:10,207 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:55:10 INFO - 2015-12-21 14:55:10,208 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:55:10 INFO - 2015-12-21 14:55:10,208 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 14:55:10 INFO - 2015-12-21 14:55:10,208 DEBUG : BROWSER_OUTPUT: __metrics 14:55:10 INFO - 2015-12-21 14:55:10,330 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:55:11 INFO - 2015-12-21 14:55:11,642 INFO : Browser initialized. 14:55:11 INFO - 2015-12-21 14:55:11,643 INFO : Running cycle 1/1 for v8_7 test... 14:55:11 INFO - 2015-12-21 14:55:11,643 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJbHOfQ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:55:23 INFO - 2015-12-21 14:55:23,193 DEBUG : BROWSER_OUTPUT: RSS: Main: 128720896 14:55:23 INFO - 2015-12-21 14:55:23,193 DEBUG : BROWSER_OUTPUT: 14:55:44 INFO - 2015-12-21 14:55:44,545 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44258/tests/v8_7/run.html (next: http://localhost:44258/tests/v8_7/run.html) 14:55:44 INFO - 2015-12-21 14:55:44,788 DEBUG : BROWSER_OUTPUT: RSS: Main: 419233792 14:55:44 INFO - 2015-12-21 14:55:44,788 DEBUG : BROWSER_OUTPUT: 14:55:44 INFO - 2015-12-21 14:55:44,789 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:55:44 INFO - 2015-12-21 14:55:44,789 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:55:44 INFO - 2015-12-21 14:55:44,789 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:55:44 INFO - 2015-12-21 14:55:44,790 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:55:44 INFO - 2015-12-21 14:55:44,790 DEBUG : BROWSER_OUTPUT: |0;Richards;163.1055292774425 14:55:44 INFO - 2015-12-21 14:55:44,790 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;170.2707304614337 14:55:44 INFO - 2015-12-21 14:55:44,790 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.4076557697681 14:55:44 INFO - 2015-12-21 14:55:44,790 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5030.150753768844 14:55:44 INFO - 2015-12-21 14:55:44,790 DEBUG : BROWSER_OUTPUT: |4;RayTrace;939.8496240601504 14:55:44 INFO - 2015-12-21 14:55:44,790 DEBUG : BROWSER_OUTPUT: |5;Earley;551.5719801434087 14:55:44 INFO - 2015-12-21 14:55:44,790 DEBUG : BROWSER_OUTPUT: |6;Boyer;10526.315789473685 14:55:44 INFO - 2015-12-21 14:55:44,791 DEBUG : BROWSER_OUTPUT: |7;RegExp;25923.076923076922 14:55:44 INFO - 2015-12-21 14:55:44,791 DEBUG : BROWSER_OUTPUT: |8;Splay;534.4735435595938 14:55:44 INFO - 2015-12-21 14:55:44,791 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4845.410628019324 14:55:44 INFO - 2015-12-21 14:55:44,791 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:55:44 INFO - 2015-12-21 14:55:44,792 DEBUG : BROWSER_OUTPUT: __startTimestamp1450738544788__endTimestamp 14:55:44 INFO - 2015-12-21 14:55:44,792 DEBUG : BROWSER_OUTPUT: 14:55:44 INFO - 2015-12-21 14:55:44,792 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:55:44 INFO - 2015-12-21 14:55:44,792 DEBUG : BROWSER_OUTPUT: Number of tests: 10 14:55:44 INFO - 2015-12-21 14:55:44,792 DEBUG : BROWSER_OUTPUT: 14:55:44 INFO - 2015-12-21 14:55:44,792 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:163.11 Median:163.11 stddev:0.00 (0.0%) 14:55:44 INFO - 2015-12-21 14:55:44,793 DEBUG : BROWSER_OUTPUT: Values: 163.1 14:55:44 INFO - 2015-12-21 14:55:44,793 DEBUG : BROWSER_OUTPUT: 14:55:44 INFO - 2015-12-21 14:55:44,793 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:170.27 Median:170.27 stddev:0.00 (0.0%) 14:55:44 INFO - 2015-12-21 14:55:44,793 DEBUG : BROWSER_OUTPUT: Values: 170.3 14:55:44 INFO - 2015-12-21 14:55:44,793 DEBUG : BROWSER_OUTPUT: 14:55:44 INFO - 2015-12-21 14:55:44,795 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.41 Median:279.41 stddev:0.00 (0.0%) 14:55:44 INFO - 2015-12-21 14:55:44,795 DEBUG : BROWSER_OUTPUT: Values: 279.4 14:55:44 INFO - 2015-12-21 14:55:44,795 DEBUG : BROWSER_OUTPUT: 14:55:44 INFO - 2015-12-21 14:55:44,795 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5030.15 Median:5030.15 stddev:0.00 (0.0%) 14:55:44 INFO - 2015-12-21 14:55:44,795 DEBUG : BROWSER_OUTPUT: Values: 5030.2 14:55:44 INFO - 2015-12-21 14:55:44,795 DEBUG : BROWSER_OUTPUT: 14:55:44 INFO - 2015-12-21 14:55:44,795 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:939.85 Median:939.85 stddev:0.00 (0.0%) 14:55:44 INFO - 2015-12-21 14:55:44,795 DEBUG : BROWSER_OUTPUT: Values: 939.8 14:55:44 INFO - 2015-12-21 14:55:44,795 DEBUG : BROWSER_OUTPUT: 14:55:44 INFO - 2015-12-21 14:55:44,795 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:551.57 Median:551.57 stddev:0.00 (0.0%) 14:55:44 INFO - 2015-12-21 14:55:44,795 DEBUG : BROWSER_OUTPUT: Values: 551.6 14:55:44 INFO - 2015-12-21 14:55:44,795 DEBUG : BROWSER_OUTPUT: 14:55:44 INFO - 2015-12-21 14:55:44,795 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10526.32 Median:10526.32 stddev:0.00 (0.0%) 14:55:44 INFO - 2015-12-21 14:55:44,795 DEBUG : BROWSER_OUTPUT: Values: 10526.3 14:55:44 INFO - 2015-12-21 14:55:44,795 DEBUG : BROWSER_OUTPUT: 14:55:44 INFO - 2015-12-21 14:55:44,796 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25923.08 Median:25923.08 stddev:0.00 (0.0%) 14:55:44 INFO - 2015-12-21 14:55:44,796 DEBUG : BROWSER_OUTPUT: Values: 25923.1 14:55:44 INFO - 2015-12-21 14:55:44,796 DEBUG : BROWSER_OUTPUT: 14:55:44 INFO - 2015-12-21 14:55:44,796 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:534.47 Median:534.47 stddev:0.00 (0.0%) 14:55:44 INFO - 2015-12-21 14:55:44,796 DEBUG : BROWSER_OUTPUT: Values: 534.5 14:55:44 INFO - 2015-12-21 14:55:44,796 DEBUG : BROWSER_OUTPUT: 14:55:44 INFO - 2015-12-21 14:55:44,796 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 14:55:44 INFO - 2015-12-21 14:55:44,796 DEBUG : BROWSER_OUTPUT: Values: 4845.4 14:55:44 INFO - 2015-12-21 14:55:44,796 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:55:44 INFO - 2015-12-21 14:55:44,796 DEBUG : BROWSER_OUTPUT: 14:55:45 INFO - 2015-12-21 14:55:45,470 INFO : Browser exited with error code: 0 14:55:45 INFO - 2015-12-21 14:55:45,482 INFO : Completed test v8_7 (00:00:39) 14:55:45 INFO - 2015-12-21 14:55:45,866 INFO : Completed test suite (00:20:07) 14:55:45 INFO - 2015-12-21 14:55:45,866 DEBUG : Working with test: dromaeo_css 14:55:45 INFO - 2015-12-21 14:55:45,866 DEBUG : Generating results file: dromaeo_css 14:55:45 INFO - 2015-12-21 14:55:45,867 DEBUG : Working with test: kraken 14:55:45 INFO - 2015-12-21 14:55:45,867 DEBUG : Generating results file: kraken 14:55:45 INFO - 2015-12-21 14:55:45,868 INFO : javascript benchmark 14:55:45 INFO - 2015-12-21 14:55:45,868 DEBUG : Working with test: v8_7 14:55:45 INFO - 2015-12-21 14:55:45,868 DEBUG : Generating results file: v8_7 14:55:45 INFO - 2015-12-21 14:55:45,868 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:55:46 INFO - 2015-12-21 14:55:46,017 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,53,35]] 14:55:46 INFO - 2015-12-21 14:55:46,017 DEBUG : process_Request line: dromaeo_css 7102.99 graph.html#tests=[[72,53,35]] 14:55:46 INFO - 2015-12-21 14:55:46,017 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:55:46 INFO - 2015-12-21 14:55:46,058 DEBUG : process_Request line: kraken 1454.70 graph.html#tests=[[232,53,35]] 14:55:46 INFO - 2015-12-21 14:55:46,058 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:55:46 INFO - 2015-12-21 14:55:46,108 DEBUG : process_Request line: v8_7 23115.92 graph.html#tests=[[230,53,35]] 14:55:46 INFO - 2015-12-21 14:55:46,109 INFO : javascript benchmark 14:55:46 INFO - 2015-12-21 14:55:46,113 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3256.5929258842643, 3368.831558422078, 3385.272166484207, 3400.3199360127983, 3400.5919289685244, 5488.725563721813, 5518.9724051379735, 5530.668159910409, 5546.306711661043, 5566.749496272667, 5498.120300751871, 5540.085885828844, 5561.4716601922855, 5571.220029195916, 5576.888462230753, 4816.060868130716, 5010.824621138261, 5027.748612569357, 5109.437961824215, 5116.104681680709, 4992.525710057557, 5030.7987680492915, 5031.3207716958295, 5038.319826823368, 5044.621653375993, 5034.043531728978, 5037.596992240612, 5089.3638295213095, 5113.360829896263, 5119.462456442076, 4920.434150072751, 5038.899222015576, 5045.41977672565, 5048.596112311043, 5086.491350864921, 5061.114304996611, 5076.568491678212, 5080.568151707109, 5093.236014597803, 5120.462351453119, 5184.144616138333, 5189.6886186828915, 5294.126469132589, 5382.085045542267, 5389.973050134763, 5864.091065884794, 5882.794102206402, 5887.4406931341455, 5951.375105613892, 5988.730507127189, 5901.586888917777, 5908.556858235606, 5913.024350982083, 5917.289925209003, 5921.674307913063, 5371.462853714636, 5413.566914646897, 5469.671819690831, 5517.917231241535, 5545.362283337387, 6015.0676645120075, 6015.217423800758, 6025.0, 6086.813236197308, 6093.360197179321, 5825.2135961644635, 5867.090600956859, 5870.412958704181, 5889.146073819272, 5904.498117660047, 5737.254156959652, 5791.189233507313, 5820.563457740686, 5916.26046744157, 5962.880742385215, 5814.04068328721, 5941.58408911372, 5963.403659634002, 5972.25346831646, 5976.641401515923, 5939.3763654816485, 5963.493103086286, 5965.701714914237, 5965.731542080617, 5966.880662386728, 4451.265541185733, 4487.775611219426, 4511.887202819956, 4513.187626227245, 4585.060062687141, 4092.0997380576227, 4092.897677558085, 4093.9385909211387, 4101.179764047202, 4125.731827431207, 5554.944450555524, 5591.329040515164, 5598.992181407304, 5599.524040456607, 5607.4112218217315, 5900.350961394243, 5916.142159386951, 5969.552283578749, 6003.249593800775, 6016.067509536029, 5624.887502250014, 5656.85857853557, 5659.971700141473, 5667.206591077253, 5668.036433806263, 4974.154393752999, 5066.847994560169, 5193.37679478465, 5207.3751149862255, 5210.76551555181, 6004.099385092184, 6113.419225173601, 6116.445413412548, 6120.257873789659, 6124.873937832686, 5911.408859114226, 5916.142159386951, 5924.585279030426, 5928.911066334009, 5934.0, 5885.411458854081, 6048.032314829782, 6076.088586712029, 6083.209182806207, 6090.817275481742, 5910.320313164041, 5911.3201981772645, 5913.881722365614, 5915.438033386821, 5919.970400148144, 5988.850278743066, 5990.7304171311525, 5994.610350327215, 5997.70011499432, 5998.580099393001, 5650.943490565041, 5701.800436984686, 5754.597178197486, 5827.213326200908, 5862.501687356623, 5750.108733146369, 5755.740991655469, 5756.0502517084215, 5758.827235182951, 5832.212651292021, 5649.830505084854, 5652.85867853307, 5654.123610840326, 5661.377248502744, 5661.801836935688, 5677.8864422710485, 5758.654480731169, 5772.04761214395, 5853.882922341444, 5887.381824908323, 5730.3410107838135, 5735.512481439125, 5759.1073383623925, 5759.481646651821, 5763.279590051244], "unit": "ms", "name": "dojo.html", "value": 5463.288768313132}, {"lowerIsBetter": false, "replicates": [568.8833789073241, 641.2913730327987, 644.5037321262628, 648.8215740671317, 655.5018186178509, 42597.0, 43412.782936085314, 43431.78284108575, 43584.56415435845, 43604.0, 46813.53186468134, 47359.76320118403, 47372.0525589488, 47382.289265660955, 47466.28800567994, 8164.1427650096775, 8253.79365515861, 9116.544172791351, 9272.490013049279, 10410.32332898363, 10705.25063245573, 10835.18736094792, 10838.295510791773, 10842.403667798268, 10849.891501085007, 10737.087347575465, 10893.291936024172, 10901.0, 10903.0, 10909.34543927363, 10739.83890241647, 10864.45677716115, 10868.61959831402, 10881.292715973437, 10887.564497420133, 10703.1437485001, 10806.675799725943, 10815.459227038695, 10843.295185812976, 10844.349339039683, 42945.57054429447, 43794.781026094985, 43884.12231755347, 43936.3409548857, 44021.33967990451, 3676.3750162472443, 3818.293615681108, 3874.9418758718643, 4120.443740095108, 4517.254652982254, 31787.682123178703, 32289.0, 32386.6761332386, 32396.6760332396, 33378.83310583456, 3243.6918492743152, 3262.9347413051605, 3355.379254837863, 3377.6453472385538, 3382.9830850845833, 316830.0, 317284.0, 319185.0, 319205.0, 320321.0, 64608.676956614916, 64937.0, 65102.674486627264, 65112.0, 65229.34770652328, 68739.31260687429, 68739.65630171917, 68858.0, 68870.31129688739, 69082.30917690859, 16744.330226791037, 17615.735763963552, 17930.641387172185, 17970.371037013643, 17988.820111798716, 12218.083643726755, 12262.570810021607, 12272.631821045383, 12296.631101066982, 14157.716845663235, 17985.50224370038, 20205.0, 21202.15191392327, 21349.03929323153, 21371.0, 8087.595620218965, 8177.632006559719, 8196.180381961756, 8314.168583141638, 8338.62476188573, 1060.7112358484478, 1108.2519299472824, 1158.5592276271816, 1185.8814118588245, 1232.2052276281747, 30341.24146896301, 30343.393132137677, 30682.84658576693, 30696.69303306983, 31119.68880311168, 1129.460424144196, 1140.3386036099043, 1152.6772503698978, 1179.952801887932, 1283.3390803736083, 14796.48212312564, 15630.9218453907, 16001.439949601709, 16246.83753162477, 17163.227654755567, 421884.0, 426552.0, 426607.0, 427638.0, 428155.0, 61093.694531527944, 61453.31280123207, 61470.0, 61537.38462615406, 61640.691796540734, 1373.6703191234033, 1435.8348789889087, 1447.1534152520894, 1468.6915747693104, 1527.4501179575343, 31393.0, 31439.371212575163, 31454.213644659067, 31882.36235275328, 32140.03579892607, 48763.512364875896, 49350.25974610456, 49386.0, 49388.75305623449, 49430.505694944026, 292661.0, 292866.0, 293137.0, 293769.0, 293779.0, 34969.47545786866, 35883.28233435369, 35963.820180898925, 36142.457863131545, 36316.81841590775, 46730.76634616805, 46791.532084678714, 47417.08642960368, 47744.0, 47999.76000120117, 38896.0, 39301.60698392979, 39410.80294598509, 39711.40432893451, 40471.19057618772, 39333.40999884947, 40231.396529052676, 40334.39498407467, 40563.594364057164, 40655.7967210162, 45081.774591126836, 45235.0, 45593.77203113963, 46032.769836150605, 46192.0, 34607.13482162966, 34643.4803477943, 34764.30471390609, 34880.127996800285, 35249.82375088108, 27579.586306205023, 28259.2935176614, 28317.57523637106, 28374.290642734097, 28650.57024144681], "unit": "ms", "name": "ext.html", "value": 20675.799720025618}, {"lowerIsBetter": false, "replicates": [372.93660077786774, 375.5343374215971, 375.7613915163871, 376.1048704084279, 384.23920637138457, 15124.848751512482, 15452.227388630552, 17704.291828326866, 18779.2488300468, 18786.06069696515, 15222.467213647524, 17743.46769596911, 18031.72952405715, 19561.608767824637, 19576.216951321967, 4983.103041452537, 5508.9724551377185, 5715.742791574389, 5719.342275638313, 5728.398518155596, 4319.935200971972, 4457.465104187502, 6038.2150320458495, 6220.751169953196, 6232.937670623303, 4965.826196083138, 6130.295016073164, 6133.6626485543275, 6136.50907927367, 6154.446099851012, 5008.699478031312, 5030.924536131961, 5063.898722025576, 5064.772085256172, 5073.644844860862, 4348.818967999451, 4421.358902959085, 4568.497465278817, 4637.6289896808175, 4643.117807616542, 14820.62948426298, 14853.0, 15072.397104115822, 15574.0, 15587.844121558866, 2137.0383327502686, 2209.558088382314, 2263.2531264682616, 2264.9433764155865, 2300.0, 10452.111570516516, 10497.4226417547, 10607.734806629896, 10700.785984280348, 10774.0, 1800.6959259130917, 1831.5329590954354, 1841.539615096226, 1872.9157187926576, 1888.490107670935, 65486.345136548975, 66378.3362166377, 66547.3345266546, 68267.0, 68380.3161968379, 7578.052743407075, 7578.924210757932, 7720.15078341382, 7771.989641346702, 7789.766307010798, 9406.0, 9411.764705882271, 9412.15290623847, 9421.764455888657, 9422.905770942203, 5870.412958704095, 6136.2636483622255, 6147.938520614826, 6198.969005154945, 6201.0388389799655, 6210.161628180138, 6261.8747625047245, 6264.906026409608, 6273.059041143773, 6333.493320534346, 3359.798412095282, 3529.5940966788635, 3595.694365978869, 3609.9639003609627, 3617.565892092913, 1225.0383448992677, 1226.2642414551199, 1227.2820400066062, 1269.4985480735058, 1289.9484020639256, 519.5298255079159, 524.9474306905333, 528.9338832645919, 533.8558589180977, 546.137103376664, 12435.253884766942, 12532.310722910144, 13203.603891883067, 13359.799603005962, 13386.19682819034, 522.2740390856712, 528.1786821492616, 529.4546616984512, 532.760257883946, 533.2694208933785, 6772.966135169293, 7077.646117694095, 7164.0, 7185.497015208885, 7198.100237470317, 627106.0226190925, 643681.0, 655183.7240813861, 658087.0, 658641.0, 83840.58079709562, 83968.16031839726, 84867.0, 84878.15121848702, 86571.56714216388, 575.5194412665471, 583.4340689531148, 585.6925114315019, 600.1268154834705, 606.2452246952572, 12162.574309899464, 12282.32447215376, 12311.076669249664, 12383.380830958236, 12427.0, 36335.0, 36405.27189456249, 36501.26997460089, 37270.44094338641, 37766.43350349692, 49831.75084124701, 50266.74866625643, 51014.489855100976, 51522.22716659328, 51658.225126622376, 7390.96304518474, 7468.402527797654, 7768.417368697484, 7778.805529861799, 7783.338416234684, 13585.59243222705, 13833.515826946008, 13839.723205536035, 13855.72288554203, 14121.858781412055, 10022.749431264278, 10343.224258180517, 11042.447877606248, 11403.258788178742, 11470.655880323604, 11136.10911127124, 11303.321800691985, 11576.826347604625, 11597.6520704379, 11703.824442633537, 12008.819867701817, 12109.33398663082, 12211.511539538318, 12241.632751017483, 12358.938205308916, 7557.319841214317, 7617.69529218825, 7636.465447418627, 7665.463417560717, 7669.386449083949, 10303.793924121326, 10426.27016108865, 10455.634052808115, 11350.94324528372, 11964.940175299416], "unit": "ms", "name": "jquery.html", "value": 7658.237697819925}, {"lowerIsBetter": false, "replicates": [1453.178953891051, 1537.0623919409159, 1540.6918616276741, 1849.2972670385257, 1853.462495876196, 7316.378107860832, 7874.56689882057, 8202.343812495, 8214.014318281814, 8225.794355141124, 8018.037835459739, 8115.837683246332, 8118.0, 8122.796930076751, 8127.187281271885, 2394.0663141374835, 2425.466397392571, 2425.745296743843, 2426.0780903256737, 2426.1265944260053, 2352.0826877517698, 2379.9643005354933, 2381.5832229359794, 2382.4163080045414, 2416.1060407649106, 2344.2732752846587, 2344.4138965258685, 2353.9646905296436, 2367.4081479630095, 2368.95262094758, 2360.1857359211044, 2364.0307473935604, 2375.2992867104244, 2392.569337519246, 2393.126508824284, 2382.4401265702545, 2428.4657375377387, 2442.1452491627965, 2443.022790883643, 2443.8655873926928, 8060.798480037987, 8100.311473524757, 8100.513969161811, 8103.635336409876, 8106.067802202763, 4899.387576552931, 4973.0, 4973.278874563204, 4984.825531106394, 4996.375453068366, 3205.1506350817053, 3223.0492004858625, 3245.0913744151676, 3245.4807230842953, 3285.2443937894177, 1004.2016596805557, 1019.8827134879509, 1036.657902892044, 1042.338115296792, 1043.6503771236644, 11223.887761122365, 11226.438678066064, 11238.325700457917, 11247.55009799607, 11248.718782030433, 4409.096135292258, 4429.15845989261, 4459.375687403766, 4462.754548499864, 4474.664400169935, 9577.712668619952, 9594.328397012143, 9595.42427454355, 9597.952010239904, 9603.231741460666, 4946.035523073038, 4986.675866068694, 4986.950130498722, 4993.925091123636, 5029.723365214948, 4115.855945041909, 4205.495340559152, 4540.727556346564, 4622.583967442946, 4625.283081122431, 3940.6059394060367, 3943.3099207638547, 3947.624975627311, 3990.74060186087, 4013.3177359848896, 1192.266755945105, 1192.528951064342, 1198.3049831097942, 1202.8255902894032, 1203.7592481503734, 1260.8108783682337, 1263.1284413754663, 1277.1379318959664, 1450.5720812360169, 1452.2883786944321, 7618.085829700472, 7876.72431464896, 8063.838723225503, 8114.513129212148, 8134.349252059821, 1230.3725100198783, 1234.7283597608512, 1237.0907383073434, 1256.2274201366095, 1259.5969289827167, 6167.444929956236, 6382.776602818879, 6440.4847612190915, 6446.967765161238, 6448.290688024314, 9695.078967498077, 9798.461084640414, 9806.0, 9809.0, 9815.705528834147, 9087.22758565516, 9701.223902087817, 9774.120329170266, 9774.16919561831, 9804.36271642341, 7700.460967732205, 7755.689772409153, 7758.650860711282, 7765.534067956054, 7774.8056298591855, 7340.853182936205, 7628.847423051397, 7763.844723105393, 7835.098963619029, 7840.529568225925, 8413.0, 8456.83086338282, 8547.914520854712, 8572.614232359683, 8600.13998600135, 8642.0, 8692.956535217283, 8704.434211776468, 8738.21356077956, 9050.683226087056, 6641.701123449359, 6819.5226334158115, 7110.075690160246, 7195.640217989185, 7300.890486642598, 7864.252895975102, 7866.410019248465, 7905.604719764104, 7922.049354077548, 7923.128455869734, 7271.054762881004, 7437.181909989788, 7466.216047314953, 7544.622768861425, 7548.924510755041, 7359.889601655872, 7439.367653749276, 7459.850802984019, 7496.887546686913, 7532.661030253542, 7465.656181887312, 7491.9625401872645, 7506.662200201114, 7518.135414427411, 7522.548647081193, 6986.860262794818, 7032.367086961994, 7035.155781306072, 7046.365827075588, 7075.398591119812, 7030.086088808626, 7074.3633073023675, 7086.220515743367, 7090.255523169993, 7096.0420343253], "unit": "ms", "name": "mootools.html", "value": 4749.816993042187}, {"lowerIsBetter": false, "replicates": [366.25649930640793, 366.90844736907684, 371.59124962541193, 372.9477873097766, 375.2045663194029, 5958.344582095966, 5963.3738457462, 6003.099535069742, 6014.067819487981, 6027.728752206156, 5691.032524470839, 5750.166225897243, 5770.596058275923, 5873.853153671161, 5894.145348924403, 4585.151746926829, 4603.148417542749, 4614.607758340545, 4615.515370886059, 4616.884577885555, 4609.216433206363, 4610.400647915766, 4617.769111544426, 4618.745968971722, 4620.075984803053, 4591.242444996572, 4595.609373203281, 4596.885077873063, 4601.7699115044115, 4604.654650901196, 4527.343535187396, 4653.418322709661, 4668.43978722552, 4670.743109128996, 4677.087967846272, 4141.337386018223, 4141.81361838718, 4150.024744185114, 4154.563770804082, 4155.501339839208, 5669.603127781057, 5671.0, 5673.971630141823, 5676.517496012844, 5682.431756824326, 5411.458854114597, 5419.105847535191, 5420.186971954199, 5421.620486565942, 5425.104857698475, 6161.845953851145, 6239.37606239377, 6258.030005349133, 6266.811995640138, 6271.843203919893, 4526.54734526548, 4551.590356867898, 4552.68131230814, 4557.0, 4558.9772051139535, 6371.203599550056, 6433.806985790434, 6438.130852334922, 6439.098526206335, 6443.130177425987, 4655.790489427984, 4730.503297153749, 4736.123817093849, 4752.239641657387, 4755.453122890843, 4803.495632958559, 4807.326974223612, 4817.470078291385, 4842.612590992712, 4848.5636292733825, 5458.781648734085, 5458.8908221835345, 5459.727013649302, 5462.153366228241, 5464.890702186013, 6365.427111559889, 6368.904466433008, 6368.936310636835, 6370.299267080617, 6377.0, 1703.1143805221216, 1750.212404418017, 1750.3261244420735, 1752.8597712182996, 1757.349780581193, 1127.3912087472836, 1128.4470609401499, 1183.4615250061202, 1188.0970462448429, 1207.167054732232, 5972.940270597325, 6007.189029481052, 6009.06859436788, 6021.42796434338, 6027.78902738402, 6432.163818703632, 6434.195725534309, 6435.4529864962005, 6441.227052753699, 6442.8389290268115, 5904.616199947076, 5976.581639285208, 5991.760329586855, 5994.790182343597, 5996.16053752475, 3570.785752854837, 3601.4777857211084, 3605.603383627799, 3606.8376923038527, 3609.1157666371905, 6646.86706265872, 6672.7330906764155, 6677.532572719863, 6681.265060843303, 6682.365175308338, 6551.115599394021, 6681.131452911188, 6686.4985126115735, 6688.0, 6693.196816382066, 6689.732410703615, 6698.196216454056, 6700.095487109275, 6707.564008339442, 6707.6981535831, 6471.902921456088, 6503.414692677682, 6508.576942498722, 6511.088447617432, 6516.706748196438, 6298.811035668938, 6355.300916899045, 6418.326075761977, 6419.037144428373, 6421.903671444838, 6689.364510371507, 6699.564528305645, 6699.76550820719, 6701.195856497252, 6702.7654032110595, 4794.59245964083, 4796.424429068534, 4801.1117943180625, 4801.231802911518, 4801.5438533339275, 6459.709313080829, 6490.610563366213, 6501.9674901625185, 6505.21937367519, 6520.510961677988, 6218.22272215973, 6335.208098987627, 6336.17629708135, 6356.77751278703, 6357.586756860789, 6273.749050037947, 6304.84237894038, 6338.936610633835, 6344.71448784815, 6346.746130154742, 6089.117078023573, 6238.064290356483, 6243.406876346739, 6245.687715614292, 6247.812565623039, 6209.944309467311, 6365.490760739222, 6383.010633351838, 6390.872182556416, 6396.712147953446, 6209.875802484015, 6211.068339749074, 6211.130441738251, 6222.377762223922, 6240.095186197885], "unit": "ms", "name": "prototype.html", "value": 4843.145734583242}, {"lowerIsBetter": false, "replicates": [809.0614886731393, 821.1829229916234, 849.6261644876254, 864.5936409887358, 871.7036207689388, 14248.145111293317, 14545.563633090998, 14545.854541454582, 14561.854381456182, 14588.635284117903, 14137.717245655082, 14208.431662733477, 14209.07641003334, 14245.14529128253, 14263.572092837205, 768.642581199742, 782.2803021220462, 913.6482454255093, 917.4907926101012, 941.336357867705, 923.5705396990398, 928.5264515097282, 932.5523748600676, 935.6117211357279, 936.9812603747955, 817.9018517777845, 977.1352353167426, 980.1178938954962, 980.3284749946274, 982.5431174503855, 822.3421262989614, 944.1266828183936, 962.0667952086535, 963.3112324687881, 964.0841200859212, 724.9383802376805, 725.0538047847557, 725.3725527418745, 725.5864157430267, 725.7060890339421, 13072.738545229136, 13082.934585327013, 13150.0, 13161.473541058345, 13184.472621095145, 11789.646310610695, 12484.375781210994, 12565.497380104785, 12584.4337004835, 12727.554535591209, 10119.89880101197, 10273.434961077137, 10314.12329951955, 10335.069843714102, 10349.534270957825, 3532.5054492371087, 3579.230465449915, 3586.659267369596, 3590.0486371111674, 3607.4588811678195, 49770.50229497695, 49875.25187122196, 53006.20490692681, 53056.73471632617, 53112.46887531114, 9494.098060684224, 9525.095115964112, 9633.229341652792, 9669.516524173763, 9680.322377433513, 20235.0, 20288.797112028988, 20320.28878989228, 20406.285779997925, 20425.2851150212, 7144.535605185646, 7191.2449192834, 7208.24313447091, 7321.853562928712, 7322.707091716272, 4428.756418397019, 4582.610478109332, 4585.747783871919, 4606.101810146989, 4648.5119062498625, 3047.360054388603, 3085.3212293295437, 3094.3501864608684, 3095.6440009399207, 3100.5814215080677, 458.1044058864911, 459.3064472646328, 459.85284708892834, 463.1038939651785, 463.7426228443179, 620.2402057479552, 645.1097485470021, 651.9087327774115, 664.6510581944518, 669.2136739331363, 9245.3528253023, 9301.860472092923, 9379.296552758571, 9434.009429009993, 9492.857607135898, 468.2741750287041, 558.2770312445393, 596.931352894414, 640.4876099120778, 653.2748648999607, 4150.211459822684, 4270.103278311527, 4271.765052922119, 4337.609615134653, 4344.391785150082, 63331.36668633255, 64082.35917640857, 64813.67593162004, 66883.66558167178, 67013.32986670168, 53699.46300537023, 54071.72964135154, 55705.16442253369, 55877.44122558722, 56297.15554266689, 49992.50007499951, 51394.0, 51715.482845171064, 52191.47808521866, 52440.21339679908, 8055.556944368116, 8274.089850116363, 8452.873206902024, 8488.363372746946, 8741.78145546341, 38062.23875522529, 38460.80769596134, 39037.21925561416, 39059.41410878896, 39128.804355978034, 44426.33360499531, 46354.536454635025, 49147.508524914294, 49404.50595494143, 49923.25115123349, 7702.229777022253, 7791.142974272939, 7858.13560508355, 7882.172371900868, 8010.759677209693, 11829.76340473203, 11848.407579621156, 11952.34262115592, 11971.521139154336, 12355.196912200678, 11115.0, 11120.0, 11245.873153779323, 11270.211085223955, 11362.886371136183, 10872.0, 11101.278416903198, 11112.722181945515, 11178.161637877354, 11554.075673945896, 10469.528871200662, 11630.244034137753, 11640.592579260025, 11799.882001179878, 11904.880951190376, 9787.265955053257, 9921.900780992097, 9963.900360996588, 10007.199424046205, 10271.794564108526, 8971.0, 9152.908470915205, 9161.633534658538, 9273.165415112673, 9671.951640241754], "unit": "ms", "name": "yui.html", "value": 6452.974157559764}], "name": "dromaeo_css", "value": 7102.993233347964}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 110.0, 104.0, 110.0, 109.0, 110.0, 101.0, 109.0, 97.0, 108.0], "unit": "ms", "name": "ai-astar", "value": 106.6}, {"lowerIsBetter": true, "replicates": [146.0, 122.0, 143.0, 164.0, 122.0, 145.0, 155.0, 122.0, 176.0, 122.0], "unit": "ms", "name": "audio-beat-detection", "value": 141.7}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 159.0, 159.0, 162.0, 160.0, 159.0, 161.0, 161.0, 159.0], "unit": "ms", "name": "audio-dft", "value": 160.1}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 72.0, 147.0, 75.0, 72.0, 70.0, 71.0, 147.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 86.8}, {"lowerIsBetter": true, "replicates": [90.0, 89.0, 134.0, 88.0, 91.0, 89.0, 129.0, 89.0, 89.0, 135.0], "unit": "ms", "name": "audio-oscillator", "value": 102.3}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 110.0, 110.0, 109.0, 109.0, 110.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 146.0, 145.0, 145.0, 147.0, 145.0, 146.0, 146.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.0}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [55.0, 66.0, 55.0, 57.0, 54.0, 58.0, 56.0, 57.0, 54.0, 54.0], "unit": "ms", "name": "json-parse-financial", "value": 56.6}, {"lowerIsBetter": true, "replicates": [63.0, 63.0, 63.0, 64.0, 71.0, 63.0, 63.0, 63.0, 62.0, 63.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 63.8}, {"lowerIsBetter": true, "replicates": [76.0, 78.0, 76.0, 78.0, 77.0, 78.0, 75.0, 77.0, 85.0, 77.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 77.7}, {"lowerIsBetter": true, "replicates": [112.0, 114.0, 108.0, 114.0, 116.0, 108.0, 113.0, 113.0, 109.0, 111.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 111.8}, {"lowerIsBetter": true, "replicates": [136.0, 134.0, 137.0, 138.0, 132.0, 128.0, 136.0, 145.0, 133.0, 133.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 135.2}, {"lowerIsBetter": true, "replicates": [62.0, 61.0, 62.0, 61.0, 62.0, 61.0, 60.0, 61.0, 61.0, 61.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 61.2}], "name": "kraken", "value": 1454.7}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [163.1055292774425], "unit": "score", "name": "Richards", "value": 216.43656200000007}, {"lowerIsBetter": false, "replicates": [170.2707304614337], "unit": "score", "name": "DeltaBlue", "value": 388.31101400000006}, {"lowerIsBetter": false, "replicates": [279.4076557697681], "unit": "score", "name": "Encrypt", "value": 952.6617989999997}, {"lowerIsBetter": false, "replicates": [5030.150753768844], "unit": "score", "name": "Decrypt", "value": 52.91710189810189}, {"lowerIsBetter": false, "replicates": [939.8496240601504], "unit": "score", "name": "RayTrace", "value": 787.3482960000001}, {"lowerIsBetter": false, "replicates": [551.5719801434087], "unit": "score", "name": "Earley", "value": 1208.2974190000004}, {"lowerIsBetter": false, "replicates": [10526.315789473685], "unit": "score", "name": "Boyer", "value": 63.313984999999995}, {"lowerIsBetter": false, "replicates": [25923.076923076922], "unit": "score", "name": "RegExp", "value": 35.14185459940652}, {"lowerIsBetter": false, "replicates": [534.4735435595938], "unit": "score", "name": "Splay", "value": 152.46966099999992}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 23115.919308653203}]} 14:55:46 INFO - RETURN: dromaeo_css: 7102.99 14:55:46 INFO - RETURN: kraken: 1454.70 14:55:46 INFO - RETURN: v8_7: 23115.92 14:55:46 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,53,35]]", "result": "23115.92"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,53,35]]", "result": "1454.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,53,35]]", "result": "7102.99"}}} 14:55:46 INFO - Return code: 0 14:55:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 14:55:46 INFO - # TBPL SUCCESS # 14:55:46 INFO - Running post-action listener: _resource_record_post_action 14:55:46 INFO - Running post-run listener: _resource_record_post_run 14:55:47 INFO - Total resource usage - Wall time: 1223s; CPU: 13.0%; Read bytes: 532480; Write bytes: 266084352; Read time: 124; Write time: 138680 14:55:47 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 4694016; Read time: 0; Write time: 504 14:55:47 INFO - run-tests - Wall time: 1209s; CPU: 13.0%; Read bytes: 532480; Write bytes: 260526080; Read time: 124; Write time: 138140 14:55:47 INFO - Running post-run listener: _upload_blobber_files 14:55:47 INFO - Blob upload gear active. 14:55:47 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 14:55:47 INFO - Copying logs to upload dir... 14:55:47 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1262.992808 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2015-12-21 14:55:47.366894) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-21 14:55:47.370875) ========= 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=b47e8c1238be48f5acbf8f2f000001bb-1450737282.324208-468932590 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450728086/firefox-44.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009978 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450728086/firefox-44.0.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-21 14:55:47.424848) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 14:55:47.425152) ========= 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=b47e8c1238be48f5acbf8f2f000001bb-1450737282.324208-468932590 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004637 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 14:55:47.473865) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-21 14:55:47.474154) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-21 14:55:47.474448) ========= ========= Total master_lag: 0.23 =========