builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-017 starttime: 1454329126.45 results: success (0) buildid: 20160201020027 builduid: e204a77378094307a208b9235089d3fd revision: 33058a9ad6be ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-01 04:18:46.446302) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-01 04:18:46.446886) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-01 04:18:46.447167) ========= 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=0333a256a5e4f052382dd180000001b1-1454328623.636062-2120760326 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006358 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-01 04:18:46.471521) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-01 04:18:46.471814) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-01 04:18:46.513575) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-01 04:18:46.513854) ========= 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=0333a256a5e4f052382dd180000001b1-1454328623.636062-2120760326 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004557 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-01 04:18:46.564885) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-01 04:18:46.565223) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-01 04:18:46.565601) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-01 04:18:46.565883) ========= 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=0333a256a5e4f052382dd180000001b1-1454328623.636062-2120760326 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-01 04:18:48-- 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% 208M=0s 2016-02-01 04:18:48 (208 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.175684 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-01 04:18:46.753782) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-01 04:18:46.754087) ========= 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=0333a256a5e4f052382dd180000001b1-1454328623.636062-2120760326 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019896 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-01 04:18:46.806949) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-01 04:18:46.807720) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 33058a9ad6be --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 33058a9ad6be --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=0333a256a5e4f052382dd180000001b1-1454328623.636062-2120760326 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-01 04:18:48,936 Setting DEBUG logging. 2016-02-01 04:18:48,936 attempt 1/10 2016-02-01 04:18:48,937 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/33058a9ad6be?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-01 04:18:49,427 unpacking tar archive at: mozilla-beta-33058a9ad6be/testing/mozharness/ program finished with exit code 0 elapsedTime=0.780306 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-01 04:18:47.603199) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-01 04:18:47.603590) ========= echo 33058a9ad6be in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'33058a9ad6be'] 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=0333a256a5e4f052382dd180000001b1-1454328623.636062-2120760326 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 33058a9ad6be program finished with exit code 0 elapsedTime=0.004048 script_repo_revision: '33058a9ad6be' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-01 04:18:47.652979) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-01 04:18:47.653326) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-01 04:18:47.664790) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-02-01 04:18:47.665125) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0333a256a5e4f052382dd180000001b1-1454328623.636062-2120760326 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:18:49 INFO - MultiFileLogger online at 20160201 04:18:49 in /builds/slave/test-pgo 04:18:49 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 04:18:49 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 04:18:49 INFO - {'append_to_log': False, 04:18:49 INFO - 'base_work_dir': '/builds/slave/test-pgo', 04:18:49 INFO - 'blob_upload_branch': 'Mozilla-Beta', 04:18:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 04:18:49 INFO - 'branch': 'Mozilla-Beta', 04:18:49 INFO - 'buildbot_json_path': 'buildprops.json', 04:18:49 INFO - 'config_files': ('talos/linux_config.py',), 04:18:49 INFO - 'default_actions': ('clobber', 04:18:49 INFO - 'read-buildbot-config', 04:18:49 INFO - 'download-and-extract', 04:18:49 INFO - 'populate-webroot', 04:18:49 INFO - 'create-virtualenv', 04:18:49 INFO - 'install', 04:18:49 INFO - 'run-tests'), 04:18:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:18:49 INFO - 'download_minidump_stackwalk': True, 04:18:49 INFO - 'download_symbols': 'ondemand', 04:18:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:18:49 INFO - 'tooltool.py': '/tools/tooltool.py', 04:18:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:18:49 INFO - '/tools/misc-python/virtualenv.py')}, 04:18:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:18:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:18:49 INFO - 'installer_path': 'installer.exe', 04:18:49 INFO - 'log_level': 'info', 04:18:49 INFO - 'log_name': 'talos', 04:18:49 INFO - 'log_to_console': True, 04:18:49 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:18:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:18:49 INFO - 'opt_config_files': (), 04:18:49 INFO - 'pip_index': False, 04:18:49 INFO - 'sps_profile': False, 04:18:49 INFO - 'sps_profile_interval': 0, 04:18:49 INFO - 'suite': 'dromaeojs', 04:18:49 INFO - 'system_bits': '32', 04:18:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:18:49 INFO - 'title': 'talos-linux64-ix-017', 04:18:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:18:49 INFO - 'use_talos_json': True, 04:18:49 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 04:18:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:18:49 INFO - 'work_dir': 'build'} 04:18:49 INFO - ##### 04:18:49 INFO - ##### Running clobber step. 04:18:49 INFO - ##### 04:18:49 INFO - Running pre-action listener: _resource_record_pre_action 04:18:49 INFO - Running main action method: clobber 04:18:49 INFO - rmtree: /builds/slave/test-pgo/build 04:18:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 04:18:50 INFO - Running post-action listener: _resource_record_post_action 04:18:50 INFO - ##### 04:18:50 INFO - ##### Running read-buildbot-config step. 04:18:50 INFO - ##### 04:18:50 INFO - Running pre-action listener: _resource_record_pre_action 04:18:50 INFO - Running main action method: read_buildbot_config 04:18:50 INFO - Using buildbot properties: 04:18:50 INFO - { 04:18:50 INFO - "properties": { 04:18:50 INFO - "buildnumber": 64, 04:18:50 INFO - "product": "firefox", 04:18:50 INFO - "script_repo_revision": "production", 04:18:50 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 04:18:50 INFO - "repository": "", 04:18:50 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 04:18:50 INFO - "buildid": "20160201020027", 04:18:50 INFO - "slavename": "talos-linux64-ix-017", 04:18:50 INFO - "pgo_build": "True", 04:18:50 INFO - "basedir": "/builds/slave/test-pgo", 04:18:50 INFO - "project": "", 04:18:50 INFO - "platform": "ubuntu64_hw", 04:18:50 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:18:50 INFO - "slavebuilddir": "test", 04:18:50 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 04:18:50 INFO - "branch": "mozilla-beta", 04:18:50 INFO - "repo_path": "releases/mozilla-beta", 04:18:50 INFO - "stage_platform": "linux64-pgo", 04:18:50 INFO - "builduid": "e204a77378094307a208b9235089d3fd", 04:18:50 INFO - "revision": "33058a9ad6be" 04:18:50 INFO - }, 04:18:50 INFO - "sourcestamp": { 04:18:50 INFO - "repository": "", 04:18:50 INFO - "hasPatch": false, 04:18:50 INFO - "project": "", 04:18:50 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 04:18:50 INFO - "changes": [ 04:18:50 INFO - { 04:18:50 INFO - "category": null, 04:18:50 INFO - "files": [ 04:18:50 INFO - { 04:18:50 INFO - "url": null, 04:18:50 INFO - "name": "http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454320827/firefox-45.0.en-US.linux-x86_64.tar.bz2" 04:18:50 INFO - } 04:18:50 INFO - ], 04:18:50 INFO - "repository": "", 04:18:50 INFO - "rev": "33058a9ad6be", 04:18:50 INFO - "who": "sendchange", 04:18:50 INFO - "when": 1454329102, 04:18:50 INFO - "number": 7542803, 04:18:50 INFO - "comments": "Bug 1241731 - Handle incomplete buffer in DiscardTransferables r=sfink a=abillings a=lizzard", 04:18:50 INFO - "project": "", 04:18:50 INFO - "at": "Mon 01 Feb 2016 04:18:22", 04:18:50 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 04:18:50 INFO - "revlink": "", 04:18:50 INFO - "properties": [ 04:18:50 INFO - [ 04:18:50 INFO - "buildid", 04:18:50 INFO - "20160201020027", 04:18:50 INFO - "Change" 04:18:50 INFO - ], 04:18:50 INFO - [ 04:18:50 INFO - "builduid", 04:18:50 INFO - "e204a77378094307a208b9235089d3fd", 04:18:50 INFO - "Change" 04:18:50 INFO - ], 04:18:50 INFO - [ 04:18:50 INFO - "pgo_build", 04:18:50 INFO - "True", 04:18:50 INFO - "Change" 04:18:50 INFO - ] 04:18:50 INFO - ], 04:18:50 INFO - "revision": "33058a9ad6be" 04:18:50 INFO - } 04:18:50 INFO - ], 04:18:50 INFO - "revision": "33058a9ad6be" 04:18:50 INFO - } 04:18:50 INFO - } 04:18:50 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454320827/firefox-45.0.en-US.linux-x86_64.tar.bz2. 04:18:50 INFO - Running post-action listener: _resource_record_post_action 04:18:50 INFO - ##### 04:18:50 INFO - ##### Running download-and-extract step. 04:18:50 INFO - ##### 04:18:50 INFO - Running pre-action listener: _resource_record_pre_action 04:18:50 INFO - Running main action method: download_and_extract 04:18:50 INFO - mkdir: /builds/slave/test-pgo/build/tests 04:18:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:18:50 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454320827/test_packages.json 04:18:50 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454320827/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 04:18:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454320827/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 04:18:50 INFO - Downloaded 1270 bytes. 04:18:50 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 04:18:50 INFO - Using the following test package requirements: 04:18:50 INFO - {u'common': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 04:18:50 INFO - u'cppunittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 04:18:50 INFO - u'firefox-45.0.en-US.linux-x86_64.cppunittest.tests.zip'], 04:18:50 INFO - u'jittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 04:18:50 INFO - u'jsshell-linux-x86_64.zip'], 04:18:50 INFO - u'mochitest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 04:18:50 INFO - u'firefox-45.0.en-US.linux-x86_64.mochitest.tests.zip'], 04:18:50 INFO - u'mozbase': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 04:18:50 INFO - u'reftest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 04:18:50 INFO - u'firefox-45.0.en-US.linux-x86_64.reftest.tests.zip'], 04:18:50 INFO - u'talos': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 04:18:50 INFO - u'firefox-45.0.en-US.linux-x86_64.talos.tests.zip'], 04:18:50 INFO - u'web-platform': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 04:18:50 INFO - u'firefox-45.0.en-US.linux-x86_64.web-platform.tests.zip'], 04:18:50 INFO - u'webapprt': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 04:18:50 INFO - u'xpcshell': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 04:18:50 INFO - u'firefox-45.0.en-US.linux-x86_64.xpcshell.tests.zip']} 04:18:50 INFO - Downloading packages: [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:18:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:18:50 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454320827/firefox-45.0.en-US.linux-x86_64.common.tests.zip 04:18:50 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454320827/firefox-45.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 04:18:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454320827/firefox-45.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:18:52 INFO - Downloaded 21580352 bytes. 04:18:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 04:18:52 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 04:18:52 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 04:18:53 INFO - Return code: 0 04:18:53 INFO - Downloading packages: [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:18:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:18:53 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454320827/firefox-45.0.en-US.linux-x86_64.common.tests.zip 04:18:53 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454320827/firefox-45.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 04:18:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454320827/firefox-45.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:18:53 INFO - Downloaded 21580352 bytes. 04:18:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 04:18:53 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 04:18:53 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 04:18:54 INFO - Return code: 0 04:18:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:18:54 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454320827/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 04:18:54 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454320827/firefox-45.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 04:18:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454320827/firefox-45.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:18:59 INFO - Downloaded 11132038 bytes. 04:18:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 04:18:59 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 04:18:59 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 04:18:59 INFO - Return code: 0 04:18:59 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')]} 04:18:59 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454320827/firefox-45.0.en-US.linux-x86_64.tar.bz2 04:18:59 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454320827/firefox-45.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.tar.bz2 04:18:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454320827/firefox-45.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:19:04 INFO - Downloaded 57952623 bytes. 04:19:04 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454320827/firefox-45.0.en-US.linux-x86_64.tar.bz2 04:19:04 INFO - mkdir: /builds/slave/test-pgo/properties 04:19:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 04:19:04 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 04:19:04 INFO - Contents: 04:19:04 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454320827/firefox-45.0.en-US.linux-x86_64.tar.bz2 04:19:04 INFO - Running post-action listener: _resource_record_post_action 04:19:04 INFO - Running post-action listener: set_extra_try_arguments 04:19:04 INFO - ##### 04:19:04 INFO - ##### Running populate-webroot step. 04:19:04 INFO - ##### 04:19:04 INFO - Running pre-action listener: _resource_record_pre_action 04:19:04 INFO - Running main action method: populate_webroot 04:19:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:19:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:19:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:19:04 INFO - '--tppagecycles', 04:19:04 INFO - '7'], 04:19:04 INFO - 'tests': ['tsvgm']}}, 04:19:04 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:19:04 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:19:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:19:04 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:19:04 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:19:04 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:19:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:19:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:19:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:19:04 INFO - 'talos_options': ['--e10s'], 04:19:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:19:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:19:04 INFO - 'tests': ['damp', 'tps']}, 04:19:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:19:04 INFO - 'talos_options': ['--e10s'], 04:19:04 INFO - 'tests': ['damp', 'tps']}, 04:19:04 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:19:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:19:04 INFO - 'other': {'tests': ['a11yr', 04:19:04 INFO - 'ts_paint', 04:19:04 INFO - 'tpaint', 04:19:04 INFO - 'sessionrestore', 04:19:04 INFO - 'sessionrestore_no_auto_restore']}, 04:19:04 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:19:04 INFO - 'tests': ['a11yr', 04:19:04 INFO - 'ts_paint', 04:19:04 INFO - 'tpaint', 04:19:04 INFO - 'sessionrestore', 04:19:04 INFO - 'sessionrestore_no_auto_restore']}, 04:19:04 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:19:04 INFO - 'tests': ['a11yr', 04:19:04 INFO - 'ts_paint', 04:19:04 INFO - 'tpaint', 04:19:04 INFO - 'sessionrestore', 04:19:04 INFO - 'sessionrestore_no_auto_restore']}, 04:19:04 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:19:04 INFO - 'tests': ['a11yr', 04:19:04 INFO - 'ts_paint', 04:19:04 INFO - 'tpaint', 04:19:04 INFO - 'sessionrestore', 04:19:04 INFO - 'sessionrestore_no_auto_restore']}, 04:19:04 INFO - 'other_l64': {'tests': ['a11yr', 04:19:04 INFO - 'ts_paint', 04:19:04 INFO - 'tpaint', 04:19:04 INFO - 'sessionrestore', 04:19:04 INFO - 'sessionrestore_no_auto_restore']}, 04:19:04 INFO - 'other_nol64': {'tests': ['a11yr', 04:19:04 INFO - 'ts_paint', 04:19:04 INFO - 'tpaint', 04:19:04 INFO - 'sessionrestore', 04:19:04 INFO - 'sessionrestore_no_auto_restore']}, 04:19:04 INFO - 'svgr': {'tests': ['tsvgx', 04:19:04 INFO - 'tsvgr_opacity', 04:19:04 INFO - 'tart', 04:19:04 INFO - 'tscrollx', 04:19:04 INFO - 'cart']}, 04:19:04 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:19:04 INFO - 'tests': ['tsvgx', 04:19:04 INFO - 'tsvgr_opacity', 04:19:04 INFO - 'tart', 04:19:04 INFO - 'tscrollx', 04:19:04 INFO - 'cart']}, 04:19:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:19:04 INFO - 'tests': ['tp5o']}, 04:19:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:19:04 INFO - 'talos_options': ['--e10s'], 04:19:04 INFO - 'tests': ['tp5o']}, 04:19:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:19:04 INFO - 'talos_options': ['--xperf_path', 04:19:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:19:04 INFO - 'tests': ['tp5n']}, 04:19:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:19:04 INFO - 'talos_options': ['--e10s', 04:19:04 INFO - '--xperf_path', 04:19:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:19:04 INFO - 'tests': ['tp5n']}}, 04:19:04 INFO - 'talos.zip': {'path': '', 04:19:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:19:04 INFO - Running post-action listener: _resource_record_post_action 04:19:04 INFO - ##### 04:19:04 INFO - ##### Running create-virtualenv step. 04:19:04 INFO - ##### 04:19:04 INFO - Running pre-action listener: _resource_record_pre_action 04:19:04 INFO - Running main action method: create_virtualenv 04:19:04 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 04:19:04 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 04:19:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 04:19:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:19:04 INFO - Using real prefix '/usr' 04:19:04 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 04:19:05 INFO - Installing distribute.............................................................................................................................................................................................done. 04:19:07 INFO - Installing pip.................done. 04:19:07 INFO - Return code: 0 04:19:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 04:19: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')]} 04:19:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:19:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:19: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')]} 04:19:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:19:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:19:07 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f45d59faf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a6b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b38600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc7350>, '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 0x2bc8250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc86e0>, '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': '0333a256a5e4f052382dd180000001b1-1454328623.636062-2120760326', '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 04:19:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 04:19:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 04:19:07 INFO - Using env: {'DISPLAY': ':0', 04:19:07 INFO - 'HOME': '/home/cltbld', 04:19:07 INFO - 'LANG': 'en_US.UTF-8', 04:19:07 INFO - 'LANGUAGE': 'en_US:en', 04:19:07 INFO - 'LOGNAME': 'cltbld', 04:19:07 INFO - 'MAIL': '/var/mail/cltbld', 04:19:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:19:07 INFO - 'MOZ_NO_REMOTE': '1', 04:19:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:19:07 INFO - 'NO_EM_RESTART': '1', 04:19:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:19:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:19:07 INFO - 'PWD': '/builds/slave/test-pgo', 04:19:07 INFO - 'SHELL': '/bin/bash', 04:19:07 INFO - 'SHLVL': '1', 04:19:07 INFO - 'TERM': 'linux', 04:19:07 INFO - 'TMOUT': '86400', 04:19:07 INFO - 'USER': 'cltbld', 04:19:07 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1454328623.636062-2120760326', 04:19:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:19:07 INFO - '_': '/tools/buildbot/bin/python'} 04:19:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:19:07 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 04:19:07 INFO - Cleaning up... 04:19:07 INFO - Return code: 0 04:19:07 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 04:19: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')]} 04:19:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:19:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:19: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')]} 04:19:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:19:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:19:07 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f45d59faf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a6b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b38600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc7350>, '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 0x2bc8250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc86e0>, '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': '0333a256a5e4f052382dd180000001b1-1454328623.636062-2120760326', '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 04:19:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 04:19:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 04:19:07 INFO - Using env: {'DISPLAY': ':0', 04:19:07 INFO - 'HOME': '/home/cltbld', 04:19:07 INFO - 'LANG': 'en_US.UTF-8', 04:19:07 INFO - 'LANGUAGE': 'en_US:en', 04:19:07 INFO - 'LOGNAME': 'cltbld', 04:19:07 INFO - 'MAIL': '/var/mail/cltbld', 04:19:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:19:07 INFO - 'MOZ_NO_REMOTE': '1', 04:19:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:19:07 INFO - 'NO_EM_RESTART': '1', 04:19:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:19:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:19:07 INFO - 'PWD': '/builds/slave/test-pgo', 04:19:07 INFO - 'SHELL': '/bin/bash', 04:19:07 INFO - 'SHLVL': '1', 04:19:07 INFO - 'TERM': 'linux', 04:19:07 INFO - 'TMOUT': '86400', 04:19:07 INFO - 'USER': 'cltbld', 04:19:07 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1454328623.636062-2120760326', 04:19:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:19:07 INFO - '_': '/tools/buildbot/bin/python'} 04:19:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:19:07 INFO - Downloading/unpacking psutil>=0.7.1 04:19: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 04:19: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 04:19: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 04:19: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 04:19: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 04:19: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 04:19:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 04:19:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:19:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:19:09 INFO - Installing collected packages: psutil 04:19:09 INFO - Running setup.py install for psutil 04:19:09 INFO - building 'psutil._psutil_linux' extension 04:19:09 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 04:19:09 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 04:19:09 INFO - building 'psutil._psutil_posix' extension 04:19:09 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 04:19:10 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 04:19:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:19:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:19:10 INFO - Successfully installed psutil 04:19:10 INFO - Cleaning up... 04:19:10 INFO - Return code: 0 04:19:10 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 04:19: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')]} 04:19:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:19:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:19: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')]} 04:19:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:19:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:19:10 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f45d59faf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a6b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b38600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc7350>, '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 0x2bc8250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc86e0>, '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': '0333a256a5e4f052382dd180000001b1-1454328623.636062-2120760326', '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 04:19:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 04:19:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 04:19:10 INFO - Using env: {'DISPLAY': ':0', 04:19:10 INFO - 'HOME': '/home/cltbld', 04:19:10 INFO - 'LANG': 'en_US.UTF-8', 04:19:10 INFO - 'LANGUAGE': 'en_US:en', 04:19:10 INFO - 'LOGNAME': 'cltbld', 04:19:10 INFO - 'MAIL': '/var/mail/cltbld', 04:19:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:19:10 INFO - 'MOZ_NO_REMOTE': '1', 04:19:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:19:10 INFO - 'NO_EM_RESTART': '1', 04:19:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:19:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:19:10 INFO - 'PWD': '/builds/slave/test-pgo', 04:19:10 INFO - 'SHELL': '/bin/bash', 04:19:10 INFO - 'SHLVL': '1', 04:19:10 INFO - 'TERM': 'linux', 04:19:10 INFO - 'TMOUT': '86400', 04:19:10 INFO - 'USER': 'cltbld', 04:19:10 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1454328623.636062-2120760326', 04:19:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:19:10 INFO - '_': '/tools/buildbot/bin/python'} 04:19:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:19:10 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:19:10 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 04:19:10 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 04:19:10 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 04:19:10 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 04:19:10 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 04:19:10 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 04:19:12 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:19:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:19:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:19:12 INFO - Installing collected packages: mozsystemmonitor 04:19:12 INFO - Running setup.py install for mozsystemmonitor 04:19:12 INFO - Successfully installed mozsystemmonitor 04:19:12 INFO - Cleaning up... 04:19:12 INFO - Return code: 0 04:19:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 04:19:12 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')]} 04:19:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:19:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:19:12 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')]} 04:19:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:19:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:19:12 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f45d59faf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a6b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b38600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc7350>, '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 0x2bc8250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc86e0>, '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': '0333a256a5e4f052382dd180000001b1-1454328623.636062-2120760326', '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 04:19:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 04:19:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 04:19:12 INFO - Using env: {'DISPLAY': ':0', 04:19:12 INFO - 'HOME': '/home/cltbld', 04:19:12 INFO - 'LANG': 'en_US.UTF-8', 04:19:12 INFO - 'LANGUAGE': 'en_US:en', 04:19:12 INFO - 'LOGNAME': 'cltbld', 04:19:12 INFO - 'MAIL': '/var/mail/cltbld', 04:19:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:19:12 INFO - 'MOZ_NO_REMOTE': '1', 04:19:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:19:12 INFO - 'NO_EM_RESTART': '1', 04:19:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:19:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:19:12 INFO - 'PWD': '/builds/slave/test-pgo', 04:19:12 INFO - 'SHELL': '/bin/bash', 04:19:12 INFO - 'SHLVL': '1', 04:19:12 INFO - 'TERM': 'linux', 04:19:12 INFO - 'TMOUT': '86400', 04:19:12 INFO - 'USER': 'cltbld', 04:19:12 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1454328623.636062-2120760326', 04:19:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:19:12 INFO - '_': '/tools/buildbot/bin/python'} 04:19:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:19:12 INFO - Downloading/unpacking blobuploader==1.2.4 04:19:12 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 04:19:12 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 04:19:12 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 04:19:12 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 04:19:12 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 04:19:12 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 04:19:14 INFO - Downloading blobuploader-1.2.4.tar.gz 04:19:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:19:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:19:14 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 04:19:14 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 04:19:14 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 04:19:14 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 04:19:14 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 04:19:14 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 04:19:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 04:19:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:19:14 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 04:19:14 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 04:19:14 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 04:19:14 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 04:19:14 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 04:19:14 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 04:19:14 INFO - Downloading docopt-0.6.1.tar.gz 04:19:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 04:19:15 INFO - Installing collected packages: blobuploader, requests, docopt 04:19:15 INFO - Running setup.py install for blobuploader 04:19:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:19:15 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 04:19:15 INFO - Running setup.py install for requests 04:19:15 INFO - Running setup.py install for docopt 04:19:15 INFO - Successfully installed blobuploader requests docopt 04:19:15 INFO - Cleaning up... 04:19:15 INFO - Return code: 0 04:19:15 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:19:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:19:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:19:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:19:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:19:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:19:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:19:15 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--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 0x7f45d59faf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a6b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b38600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc7350>, '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 0x2bc8250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc86e0>, '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': '0333a256a5e4f052382dd180000001b1-1454328623.636062-2120760326', '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 04:19:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--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 04:19:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --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 04:19:15 INFO - Using env: {'DISPLAY': ':0', 04:19:15 INFO - 'HOME': '/home/cltbld', 04:19:15 INFO - 'LANG': 'en_US.UTF-8', 04:19:15 INFO - 'LANGUAGE': 'en_US:en', 04:19:15 INFO - 'LOGNAME': 'cltbld', 04:19:15 INFO - 'MAIL': '/var/mail/cltbld', 04:19:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:19:15 INFO - 'MOZ_NO_REMOTE': '1', 04:19:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:19:15 INFO - 'NO_EM_RESTART': '1', 04:19:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:19:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:19:15 INFO - 'PWD': '/builds/slave/test-pgo', 04:19:15 INFO - 'SHELL': '/bin/bash', 04:19:15 INFO - 'SHLVL': '1', 04:19:15 INFO - 'TERM': 'linux', 04:19:15 INFO - 'TMOUT': '86400', 04:19:15 INFO - 'USER': 'cltbld', 04:19:15 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1454328623.636062-2120760326', 04:19:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:19:15 INFO - '_': '/tools/buildbot/bin/python'} 04:19:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:19:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:19:15 INFO - Running setup.py (path:/tmp/pip-b83N3D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:19:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:19:15 INFO - Running setup.py (path:/tmp/pip-Ac9GFF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:19:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:19:16 INFO - Running setup.py (path:/tmp/pip-9igsSZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:19:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:19:16 INFO - Running setup.py (path:/tmp/pip-Dq3DjO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:19:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:19:16 INFO - Running setup.py (path:/tmp/pip-yUutOL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:19:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:19:16 INFO - Running setup.py (path:/tmp/pip-nj0vyr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:19:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:19:16 INFO - Running setup.py (path:/tmp/pip-x_wNRN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:19:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:19:16 INFO - Running setup.py (path:/tmp/pip-tOIzVc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:19:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:19:16 INFO - Running setup.py (path:/tmp/pip-hy55Kk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:19:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:19:16 INFO - Running setup.py (path:/tmp/pip-lKD0Kq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:19:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:19:16 INFO - Running setup.py (path:/tmp/pip-srvr6L-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:19:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:19:16 INFO - Running setup.py (path:/tmp/pip-gETmze-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:19:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:19:16 INFO - Running setup.py (path:/tmp/pip-R16EED-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:19:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:19:16 INFO - Running setup.py (path:/tmp/pip-hHpEkV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:19:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:19:16 INFO - Running setup.py (path:/tmp/pip-VT8wP3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:19:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:19:16 INFO - Running setup.py (path:/tmp/pip-kWHk10-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:19:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:19:17 INFO - Running setup.py (path:/tmp/pip-oXvpSr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:19:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:19:17 INFO - Running setup.py install for manifestparser 04:19:17 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 04:19:17 INFO - Running setup.py install for mozcrash 04:19:17 INFO - Running setup.py install for mozdebug 04:19:17 INFO - Running setup.py install for mozdevice 04:19:17 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 04:19:17 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 04:19:17 INFO - Running setup.py install for mozfile 04:19:17 INFO - Running setup.py install for mozhttpd 04:19:17 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 04:19:17 INFO - Running setup.py install for mozinfo 04:19:17 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 04:19:17 INFO - Running setup.py install for mozInstall 04:19:17 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 04:19:17 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 04:19:17 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 04:19:17 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 04:19:17 INFO - Running setup.py install for mozleak 04:19:17 INFO - Running setup.py install for mozlog 04:19:18 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 04:19:18 INFO - Running setup.py install for moznetwork 04:19:18 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 04:19:18 INFO - Running setup.py install for mozprocess 04:19:18 INFO - Running setup.py install for mozprofile 04:19:18 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 04:19:18 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 04:19:18 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 04:19:18 INFO - Running setup.py install for mozrunner 04:19:18 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 04:19:18 INFO - Running setup.py install for mozscreenshot 04:19:18 INFO - Running setup.py install for moztest 04:19:18 INFO - Running setup.py install for mozversion 04:19:18 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 04:19:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:19:18 INFO - Cleaning up... 04:19:18 INFO - Return code: 0 04:19:18 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:19:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:19:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:19:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:19:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:19:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:19:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:19:18 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f45d59faf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a6b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b38600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc7350>, '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 0x2bc8250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc86e0>, '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': '0333a256a5e4f052382dd180000001b1-1454328623.636062-2120760326', '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 04:19:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 04:19:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 04:19:18 INFO - Using env: {'DISPLAY': ':0', 04:19:18 INFO - 'HOME': '/home/cltbld', 04:19:18 INFO - 'LANG': 'en_US.UTF-8', 04:19:18 INFO - 'LANGUAGE': 'en_US:en', 04:19:18 INFO - 'LOGNAME': 'cltbld', 04:19:18 INFO - 'MAIL': '/var/mail/cltbld', 04:19:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:19:18 INFO - 'MOZ_NO_REMOTE': '1', 04:19:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:19:18 INFO - 'NO_EM_RESTART': '1', 04:19:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:19:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:19:18 INFO - 'PWD': '/builds/slave/test-pgo', 04:19:18 INFO - 'SHELL': '/bin/bash', 04:19:18 INFO - 'SHLVL': '1', 04:19:18 INFO - 'TERM': 'linux', 04:19:18 INFO - 'TMOUT': '86400', 04:19:18 INFO - 'USER': 'cltbld', 04:19:18 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1454328623.636062-2120760326', 04:19:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:19:18 INFO - '_': '/tools/buildbot/bin/python'} 04:19:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:19:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:19:19 INFO - Running setup.py (path:/tmp/pip-FUvBLM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:19:19 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)) 04:19:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:19:19 INFO - Running setup.py (path:/tmp/pip-igdveq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:19:19 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)) 04:19:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:19:19 INFO - Running setup.py (path:/tmp/pip-TwXSpC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:19:19 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)) 04:19:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:19:19 INFO - Running setup.py (path:/tmp/pip-OI4Rh8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:19:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 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)) 04:19:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:19:19 INFO - Running setup.py (path:/tmp/pip-cYvwDo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:19:19 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)) 04:19:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:19:19 INFO - Running setup.py (path:/tmp/pip-P1V3Pj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:19:19 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)) 04:19:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:19:19 INFO - Running setup.py (path:/tmp/pip-Ix6D2S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:19:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 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)) 04:19:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:19:19 INFO - Running setup.py (path:/tmp/pip-jsCgzI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:19:19 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)) 04:19:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:19:19 INFO - Running setup.py (path:/tmp/pip-_QBqtQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:19:19 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)) 04:19:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:19:19 INFO - Running setup.py (path:/tmp/pip-UDTpwY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:19:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 04:19:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:19:19 INFO - Running setup.py (path:/tmp/pip-xY4StQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:19:19 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)) 04:19:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:19:19 INFO - Running setup.py (path:/tmp/pip-TehsSl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:19:19 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)) 04:19:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:19:19 INFO - Running setup.py (path:/tmp/pip-DqANjD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:19:20 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)) 04:19:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:19:20 INFO - Running setup.py (path:/tmp/pip-bX8TnJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:19:20 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)) 04:19:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:19:20 INFO - Running setup.py (path:/tmp/pip-tRGN5G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:19:20 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)) 04:19:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:19:20 INFO - Running setup.py (path:/tmp/pip-pXKITm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:19:20 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)) 04:19:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:19:20 INFO - Running setup.py (path:/tmp/pip-Thg7EB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:19:20 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)) 04:19:20 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)) 04:19:20 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)) 04:19:20 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)) 04:19:20 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.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 04:19:20 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.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 04:19:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 04:19: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 04:19: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 04:19: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 04:19: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 04:19: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 04:19: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 04:19:22 INFO - Downloading blessings-1.6.tar.gz 04:19:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 04:19:22 INFO - Installing collected packages: blessings 04:19:22 INFO - Running setup.py install for blessings 04:19:22 INFO - Successfully installed blessings 04:19:22 INFO - Cleaning up... 04:19:22 INFO - Return code: 0 04:19:22 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 04:19:22 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:19:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:19:22 INFO - Reading from file tmpfile_stdout 04:19:22 INFO - Current package versions: 04:19:22 INFO - argparse == 1.2.1 04:19:22 INFO - blessings == 1.6 04:19:22 INFO - blobuploader == 1.2.4 04:19:22 INFO - docopt == 0.6.1 04:19:22 INFO - manifestparser == 1.1 04:19:22 INFO - mozInstall == 1.12 04:19:22 INFO - mozcrash == 0.16 04:19:22 INFO - mozdebug == 0.1 04:19:22 INFO - mozdevice == 0.47 04:19:22 INFO - mozfile == 1.2 04:19:22 INFO - mozhttpd == 0.7 04:19:22 INFO - mozinfo == 0.9 04:19:22 INFO - mozleak == 0.1 04:19:22 INFO - mozlog == 3.1 04:19:22 INFO - moznetwork == 0.27 04:19:22 INFO - mozprocess == 0.22 04:19:22 INFO - mozprofile == 0.27 04:19:22 INFO - mozrunner == 6.11 04:19:22 INFO - mozscreenshot == 0.1 04:19:22 INFO - mozsystemmonitor == 0.0 04:19:22 INFO - moztest == 0.7 04:19:22 INFO - mozversion == 1.4 04:19:22 INFO - psutil == 3.1.1 04:19:22 INFO - requests == 1.2.3 04:19:22 INFO - wsgiref == 0.1.2 04:19:22 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:19:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:19:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:19:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:19:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:19:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:19:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:19:22 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f45d59faf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a6b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b38600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc7350>, '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 0x2bc8250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc86e0>, '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': '0333a256a5e4f052382dd180000001b1-1454328623.636062-2120760326', '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 04:19:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 04:19:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 04:19:22 INFO - Using env: {'DISPLAY': ':0', 04:19:22 INFO - 'HOME': '/home/cltbld', 04:19:22 INFO - 'LANG': 'en_US.UTF-8', 04:19:22 INFO - 'LANGUAGE': 'en_US:en', 04:19:22 INFO - 'LOGNAME': 'cltbld', 04:19:22 INFO - 'MAIL': '/var/mail/cltbld', 04:19:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:19:22 INFO - 'MOZ_NO_REMOTE': '1', 04:19:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:19:22 INFO - 'NO_EM_RESTART': '1', 04:19:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:19:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:19:22 INFO - 'PWD': '/builds/slave/test-pgo', 04:19:22 INFO - 'SHELL': '/bin/bash', 04:19:22 INFO - 'SHLVL': '1', 04:19:22 INFO - 'TERM': 'linux', 04:19:22 INFO - 'TMOUT': '86400', 04:19:22 INFO - 'USER': 'cltbld', 04:19:22 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1454328623.636062-2120760326', 04:19:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:19:22 INFO - '_': '/tools/buildbot/bin/python'} 04:19:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:19:22 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)) 04:19:22 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)) 04:19:22 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)) 04:19:22 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)) 04:19:22 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)) 04:19:22 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)) 04:19:22 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)) 04:19:22 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)) 04:19:22 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)) 04:19:22 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)) 04:19:22 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)) 04:19:22 INFO - Cleaning up... 04:19:22 INFO - Return code: 0 04:19:22 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 04:19:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:19:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:19:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:19:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:19:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:19:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:19:22 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f45d59faf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a6b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b38600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc7350>, '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 0x2bc8250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc86e0>, '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': '0333a256a5e4f052382dd180000001b1-1454328623.636062-2120760326', '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 04:19:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 04:19:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 04:19:22 INFO - Using env: {'DISPLAY': ':0', 04:19:22 INFO - 'HOME': '/home/cltbld', 04:19:22 INFO - 'LANG': 'en_US.UTF-8', 04:19:22 INFO - 'LANGUAGE': 'en_US:en', 04:19:22 INFO - 'LOGNAME': 'cltbld', 04:19:22 INFO - 'MAIL': '/var/mail/cltbld', 04:19:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:19:22 INFO - 'MOZ_NO_REMOTE': '1', 04:19:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:19:22 INFO - 'NO_EM_RESTART': '1', 04:19:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:19:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:19:22 INFO - 'PWD': '/builds/slave/test-pgo', 04:19:22 INFO - 'SHELL': '/bin/bash', 04:19:22 INFO - 'SHLVL': '1', 04:19:22 INFO - 'TERM': 'linux', 04:19:22 INFO - 'TMOUT': '86400', 04:19:22 INFO - 'USER': 'cltbld', 04:19:22 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1454328623.636062-2120760326', 04:19:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:19:22 INFO - '_': '/tools/buildbot/bin/python'} 04:19:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:19:22 INFO - Downloading/unpacking jsonschema 04:19: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 04:19: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 04:19: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 04:19: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 04:19: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 04:19: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 04:19:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:19:24 INFO - Downloading/unpacking functools32 (from jsonschema) 04:19:24 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 04:19:24 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 04:19:24 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 04:19:24 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 04:19:24 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 04:19:24 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 04:19:24 INFO - Downloading functools32-3.2.3-2.tar.gz 04:19:24 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 04:19:25 INFO - warning: no files found matching '*.txt' 04:19:25 INFO - no previously-included directories found matching 'build' 04:19:25 INFO - no previously-included directories found matching 'dist' 04:19:25 INFO - no previously-included directories found matching '.git*' 04:19:25 INFO - Installing collected packages: jsonschema, functools32 04:19:25 INFO - Running setup.py install for functools32 04:19:25 INFO - warning: no files found matching '*.txt' 04:19:25 INFO - no previously-included directories found matching 'build' 04:19:25 INFO - no previously-included directories found matching 'dist' 04:19:25 INFO - no previously-included directories found matching '.git*' 04:19:25 INFO - Successfully installed jsonschema functools32 04:19:25 INFO - Cleaning up... 04:19:25 INFO - Return code: 0 04:19:25 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 04:19:25 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')]} 04:19:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:19:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:19:25 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')]} 04:19:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:19:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:19:25 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f45d59faf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a6b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b38600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc7350>, '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 0x2bc8250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc86e0>, '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': '0333a256a5e4f052382dd180000001b1-1454328623.636062-2120760326', '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 04:19:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 04:19:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 04:19:25 INFO - Using env: {'DISPLAY': ':0', 04:19:25 INFO - 'HOME': '/home/cltbld', 04:19:25 INFO - 'LANG': 'en_US.UTF-8', 04:19:25 INFO - 'LANGUAGE': 'en_US:en', 04:19:25 INFO - 'LOGNAME': 'cltbld', 04:19:25 INFO - 'MAIL': '/var/mail/cltbld', 04:19:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:19:25 INFO - 'MOZ_NO_REMOTE': '1', 04:19:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:19:25 INFO - 'NO_EM_RESTART': '1', 04:19:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:19:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:19:25 INFO - 'PWD': '/builds/slave/test-pgo', 04:19:25 INFO - 'SHELL': '/bin/bash', 04:19:25 INFO - 'SHLVL': '1', 04:19:25 INFO - 'TERM': 'linux', 04:19:25 INFO - 'TMOUT': '86400', 04:19:25 INFO - 'USER': 'cltbld', 04:19:25 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1454328623.636062-2120760326', 04:19:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:19:25 INFO - '_': '/tools/buildbot/bin/python'} 04:19:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:19:25 INFO - Downloading/unpacking flake8 04:19:25 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 04:19:25 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 04:19:25 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 04:19:25 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 04:19:25 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 04:19:25 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 04:19:27 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:19:27 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:19:27 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 04:19:27 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 04:19:27 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 04:19:27 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 04:19:27 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 04:19:27 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 04:19:27 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:19:27 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:19:27 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 04:19:27 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 04:19:27 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 04:19:27 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 04:19:27 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 04:19:27 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 04:19:27 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:19:27 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 04:19:27 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 04:19:27 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 04:19:27 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 04:19:27 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 04:19:27 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 04:19:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 04:19:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:19:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:19:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:19:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:19:27 INFO - no previously-included directories found matching 'docs/_build' 04:19:27 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:19:27 INFO - Running setup.py install for pep8 04:19:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:19:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:19:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:19:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:19:28 INFO - no previously-included directories found matching 'docs/_build' 04:19:28 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 04:19:28 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:19:28 INFO - Cleaning up... 04:19:28 INFO - Return code: 0 04:19:28 INFO - Running post-action listener: _resource_record_post_action 04:19:28 INFO - Running post-action listener: _start_resource_monitoring 04:19:28 INFO - Starting resource monitoring. 04:19:28 INFO - ##### 04:19:28 INFO - ##### Running install step. 04:19:28 INFO - ##### 04:19:28 INFO - Running pre-action listener: _resource_record_pre_action 04:19:28 INFO - Running main action method: install 04:19:28 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:19:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:19:28 INFO - Reading from file tmpfile_stdout 04:19:28 INFO - Detecting whether we're running mozinstall >=1.0... 04:19:28 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 04:19:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 04:19:28 INFO - Reading from file tmpfile_stdout 04:19:28 INFO - Output received: 04:19:28 INFO - Usage: mozinstall [options] installer 04:19:28 INFO - Options: 04:19:28 INFO - -h, --help show this help message and exit 04:19:28 INFO - -d DEST, --destination=DEST 04:19:28 INFO - Directory to install application into. [default: 04:19:28 INFO - "/builds/slave/test-pgo"] 04:19:28 INFO - --app=APP Application being installed. [default: firefox] 04:19:28 INFO - mkdir: /builds/slave/test-pgo/build/application 04:19:28 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 04:19:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 04:19:42 INFO - Reading from file tmpfile_stdout 04:19:42 INFO - Output received: 04:19:42 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 04:19:42 INFO - Running post-action listener: _resource_record_post_action 04:19:42 INFO - ##### 04:19:42 INFO - ##### Running run-tests step. 04:19:42 INFO - ##### 04:19:42 INFO - Running pre-action listener: _resource_record_pre_action 04:19:42 INFO - Running main action method: run_tests 04:19:42 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 04:19:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 04:19:42 INFO - Python 2.7.3 04:19:42 INFO - Return code: 0 04:19:42 INFO - grabbing minidump binary from tooltool 04:19:42 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')]} 04:19:42 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 0x2bc7350>, '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 0x2bc8250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc86e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 04:19:42 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 04:19:42 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 04:19:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:19:43 INFO - Return code: 0 04:19:43 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 04:19:43 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 04:19:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 04:19:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 04:19:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 04:19:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 04:19:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 04:19:44 INFO - Return code: 0 04:19:44 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/1454320827/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 04:19:44 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/1454320827/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --webServer localhost 04:19:44 INFO - Using env: {'DISPLAY': ':0', 04:19:44 INFO - 'HOME': '/home/cltbld', 04:19:44 INFO - 'LANG': 'en_US.UTF-8', 04:19:44 INFO - 'LANGUAGE': 'en_US:en', 04:19:44 INFO - 'LOGNAME': 'cltbld', 04:19:44 INFO - 'MAIL': '/var/mail/cltbld', 04:19:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:19:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 04:19:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:19:44 INFO - 'MOZ_NO_REMOTE': '1', 04:19:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:19:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:19:44 INFO - 'NO_EM_RESTART': '1', 04:19:44 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:19:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:19:44 INFO - 'PWD': '/builds/slave/test-pgo', 04:19:44 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 04:19:44 INFO - 'SHELL': '/bin/bash', 04:19:44 INFO - 'SHLVL': '1', 04:19:44 INFO - 'TERM': 'linux', 04:19:44 INFO - 'TMOUT': '86400', 04:19:44 INFO - 'USER': 'cltbld', 04:19:44 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1454328623.636062-2120760326', 04:19:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:19:44 INFO - '_': '/tools/buildbot/bin/python'} 04:19:44 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/1454320827/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost'] with output_timeout 3600 04:19:44 INFO - mozversion INFO | application_buildid: 20160201020027 04:19:44 INFO - mozversion INFO | application_changeset: 33058a9ad6be5b3f16ea1793d264006c17041da2 04:19:44 INFO - mozversion INFO | application_display_name: Nightly 04:19:44 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:19:44 INFO - mozversion INFO | application_name: Firefox 04:19:44 INFO - mozversion INFO | application_remotingname: firefox 04:19:44 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-beta 04:19:44 INFO - mozversion INFO | application_vendor: Mozilla 04:19:44 INFO - mozversion INFO | application_version: 45.0 04:19:44 INFO - mozversion INFO | platform_buildid: 20160201020027 04:19:44 INFO - mozversion INFO | platform_changeset: 33058a9ad6be5b3f16ea1793d264006c17041da2 04:19:44 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-beta 04:19:44 INFO - mozversion INFO | platform_version: 45.0 04:19:44 INFO - 2016-02-01 04:19:44,308 DEBUG : using testdate: 1454329184 04:19:44 INFO - 2016-02-01 04:19:44,308 DEBUG : actual date: 1454329184 04:19:44 INFO - 2016-02-01 04:19:44,330 INFO : starting webserver on 'localhost:49975' 04:19:44 INFO - 2016-02-01 04:19:44,331 INFO : Starting test suite talos-linux64-ix-017 04:19:44 INFO - 2016-02-01 04:19:44,331 INFO : Starting test dromaeo_css 04:19:44 INFO - 2016-02-01 04:19:44,331 DEBUG : operating with platform_type : linux_ 04:19:44 INFO - 2016-02-01 04:19:44,332 INFO : Initialising browser for dromaeo_css test... 04:19:44 INFO - 2016-02-01 04:19:44,348 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQNMmj6/profile http://localhost:49975/getInfo.html 04:19:47 INFO - 2016-02-01 04:19:47,653 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:19:47 INFO - 2016-02-01 04:19:47,653 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:19:47 INFO - 2016-02-01 04:19:47,653 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:19:47 INFO - 2016-02-01 04:19:47,653 DEBUG : BROWSER_OUTPUT: __metrics 04:19:47 INFO - 2016-02-01 04:19:47,790 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:19:48 INFO - 2016-02-01 04:19:48,568 INFO : Browser initialized. 04:19:48 INFO - 2016-02-01 04:19:48,568 INFO : Running cycle 1/1 for dromaeo_css test... 04:19:48 INFO - 2016-02-01 04:19:48,568 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQNMmj6/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:20:00 INFO - 2016-02-01 04:20:00,359 DEBUG : BROWSER_OUTPUT: RSS: Main: 134262784 04:20:00 INFO - 2016-02-01 04:20:00,360 DEBUG : BROWSER_OUTPUT: 04:20:51 INFO - 2016-02-01 04:20:51,170 DEBUG : BROWSER_OUTPUT: 1454329251168 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] 04:22:59 INFO - 2016-02-01 04:22:59,281 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49975/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49975/tests/dromaeo/cssquery-ext.html) 04:23:00 INFO - 2016-02-01 04:23:00,217 DEBUG : BROWSER_OUTPUT: RSS: Main: 218001408 04:23:00 INFO - 2016-02-01 04:23:00,217 DEBUG : BROWSER_OUTPUT: 04:26:02 INFO - 2016-02-01 04:26:02,399 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49975/tests/dromaeo/cssquery-ext.html (next: http://localhost:49975/tests/dromaeo/cssquery-jquery.html) 04:26:02 INFO - 2016-02-01 04:26:02,961 DEBUG : BROWSER_OUTPUT: RSS: Main: 224284672 04:26:02 INFO - 2016-02-01 04:26:02,961 DEBUG : BROWSER_OUTPUT: 04:29:04 INFO - 2016-02-01 04:29:04,647 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49975/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49975/tests/dromaeo/cssquery-mootools.html) 04:29:05 INFO - 2016-02-01 04:29:05,209 DEBUG : BROWSER_OUTPUT: RSS: Main: 216776704 04:29:05 INFO - 2016-02-01 04:29:05,209 DEBUG : BROWSER_OUTPUT: 04:32:06 INFO - 2016-02-01 04:32:06,880 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49975/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49975/tests/dromaeo/cssquery-prototype.html) 04:32:07 INFO - 2016-02-01 04:32:07,446 DEBUG : BROWSER_OUTPUT: RSS: Main: 201031680 04:32:07 INFO - 2016-02-01 04:32:07,446 DEBUG : BROWSER_OUTPUT: 04:35:09 INFO - 2016-02-01 04:35:09,838 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49975/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49975/tests/dromaeo/cssquery-yui.html) 04:35:10 INFO - 2016-02-01 04:35:10,404 DEBUG : BROWSER_OUTPUT: RSS: Main: 202383360 04:35:10 INFO - 2016-02-01 04:35:10,405 DEBUG : BROWSER_OUTPUT: 04:38:12 INFO - 2016-02-01 04:38:12,362 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49975/tests/dromaeo/cssquery-yui.html (next: http://localhost:49975/tests/dromaeo/cssquery-dojo.html) 04:38:12 INFO - 2016-02-01 04:38:12,612 DEBUG : BROWSER_OUTPUT: RSS: Main: 244625408 04:38:12 INFO - 2016-02-01 04:38:12,612 DEBUG : BROWSER_OUTPUT: 04:38:12 INFO - 2016-02-01 04:38:12,612 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:38:12 INFO - 2016-02-01 04:38:12,612 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:38:12 INFO - 2016-02-01 04:38:12,612 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:38:12 INFO - 2016-02-01 04:38:12,612 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:38:12 INFO - 2016-02-01 04:38:12,612 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3323;3355.3960287148334;3387.983060084701;3390.457526795713;3410.7612467127296;5482.287302650655;5505.9724701376535;5540.335159780827;5562.44375562444;5600;5563.527100196488;5588.580856435773;5619.072852979264;5621.606487545873;5624.3531993820625;4979.427365852937;5037.622178336621;5071.594272458204;5109.667871588354;5173.767180476869;5081.64428490004;5097;5097.668651537657;5103.234514822788;5137.717425541594;4887.535684110022;5042.193249080129;5046.3187469691675;5105.208692652626;5114.28400023997;5077.873053173664;5159.76781044852;5170.97414512925;5171.870703232412;5175.146100893348;5030.4215015272985;5075.492450754932;5137.229415587654;5152.4847515248175;5177.534021938043;5230.633855630107;5257.553107985826;5353.544948679367;5356.491133342326;5403.540699040586;5909.084091965752;5999.580029397944;6031.215941927521;6045.45590896817;6061.605995610315;5958.463738263577;6039.3960603939695;6084.847878803065;6086.573939824214;6087.634741915455;5444.346678398578;5527.944720552783;5539.861503462405;5618.353889302701;5628.380878103405;6026.0659597762415;6124.540659450559;6128.938710612926;6130.203073600493;6155.599886007395;5940.8811823764145;5960;5967.6121052131475;5969.940300597025;5974.1934838796205;5857.179994800731;5908.675022873697;5962.612430192024;5978.3124940631515;6006.129111278928;5948.464638182584;5962.940370596239;5963.612365196248;5967.16459695643;5967.522598192134;5655.886882262332;5932.8813423732145;5969.403059694083;5973.313068997121;5991.430814072656;4479.417675702203;4486.371907932892;4516.796744146522;4518.1415531049;4547.954520454753;4097.528784189856;4102.056526998807;4111.568285329998;4117.3206420940805;4128.958710412858;5459.208414779835;5590.049691552445;5667.121596152603;5667.979763642584;5679.886402271932;5937.435943585352;5954.3152537458745;5962.761489540457;5987.970060149759;6017.729202185912;5661.094224923992;5760.193572899798;5763.423657634287;5769.1634712967225;5783.652980821164;4994.375703037121;5092.694438333638;5219.686818790885;5245.318108645852;5280.260763493114;6201.472874805602;6216.471599914058;6222.097795819581;6226.750929962841;6229.7508099676415;6023.759049637965;6031.879362412815;6037.09443583466;6055.333913269625;6055.3987561504555;5973.790917317873;6010.068439391901;6099.207103076572;6147.108669243024;6213.068039793886;5884.58807883444;5902.911456328245;5921.496672782861;5927.585069045125;5930.466258036798;6052.969735151296;6055.182550355646;6057.212562366864;6061.1514387984835;6063.9696801517475;5656.010198215214;5745.339285982165;5776.942230577641;5843.94156058434;5847.035239185487;5843.152742852178;5856.94143058564;5857.150713146485;5871.7651293947765;5882.1470886722045;5655.519280861173;5788.82633520995;5798.797042103675;5798.94201057984;5800.8259752207505;5771.076627739541;5807.564432667651;5858.238429004202;5875.441833025856;5904.439078287556;5676.375598684059;5772.134179873053;5790.1893734877995;5835.94164058354;5841.50347220491 04:38:12 INFO - 2016-02-01 04:38:12,613 DEBUG : BROWSER_OUTPUT: |1;ext.html;610.8075956073836;615.7783198048702;619.6994457688021;632.2318383164455;639.3893831391022;32222.838885805566;32859.835700821495;40281.19437611246;40546.39180412296;40696.186076278456;44672.776636116774;45111.774441127745;45145;45176;45271;7954.482958607701;8887.022427532982;8952.194302512773;9063.773405664846;9067.546622668873;8082;10564.102051325608;10846.457677116112;10855.67432977012;10877.619283325084;10557.894421055806;10645.840312395281;10669.83995240072;10673.146148308155;10678.038976492115;10531.578736850555;10601.04590586847;10624.521896514676;10629.255952083357;10638.148948084136;10309.32989355697;10452.947735261276;10456.058954694114;10457.111145552637;10467.267291289612;42135.57864421347;42665.57334426647;42673.35989960153;42739.78630106829;42768.78615606902;3365.7139143172617;3376.5441665375106;3454.9654503454894;3708.0915175782106;3759.981200094009;31626.841865790753;31993.200169995936;31994.520082198786;32005.679943200736;32338.119425668836;4344.174606824725;4355.433793606842;4383.189110014626;4458.197524445599;4458.398116254329;282555;284749;285102.5744871283;285356;287081;58957.705211474524;59914;63760.68119659465;64062.35937640657;64159.35840641627;77604;78076;78626.21373786303;78775.60612196902;78780.6060969703;15154.621134471727;15320.157391343582;15329.9233503834;15330.080195188324;15332.233388330538;11491.540338386538;11530.59642912494;11544.191906566628;11571.479283432265;11577.421128943688;21685.783142168377;21919.452013699785;21929;22015.559688806134;22016.559668806534;7852.371810255166;8065.838683226302;8093.716719914774;8178.446095241885;8186.590670466453;1012.7012531303136;1050.9527071281811;1069.5614797932965;1147.2944139354238;1205.5539450403407;29726.851365743034;29917;30240.09279721612;30383.848080759453;30464;1062.3483070067323;1082.2910993299402;1128.3568366031448;1207.9033677305795;1220.5911019808464;13149.474021039052;15408.61478463025;15644;15955.361785528681;16239.431619893483;339221;340586;341212;342951;343343;55307;55683;55824.72087639536;55856.72071639697;55869.720651396485;1332.7734285171543;1363.604554679132;1392.1160063359637;1406.859314068585;1446.1250943179436;26846.32884177833;26919.865400672872;27023.59464607993;27469.17592472229;27580.310492237855;41480.170396592504;41737.79131104325;41800;41847.37228941507;44660.55339446694;224639;419634;425126;430808;430925;34275;34693.47959780555;34757.65242347544;34872;35049;45456.772716136205;45696.77151614221;45830.54169458263;45900;46126.30810537777;38730.6126938727;38739.41890871583;38849.22301553896;43922.560774391844;44422.66927968664;38538.80730596329;38605.4209186868;39022.80488597539;39100.80449597734;39264.2147157061;43437;43636;43726.78136609297;44009.77995110132;44420;32748.345033099682;33082.50376244407;34040.82979585086;34289.31421371608;34347.656523434445;26022.60966085548;26793.598096028963;26819.040781016716;26820.865895671177;26983.460330793667 04:38:12 INFO - 2016-02-01 04:38:12,615 DEBUG : BROWSER_OUTPUT: |2;jquery.html;385.6721786481491;390.78116254897253;391.86359557283873;392.0825268870845;392.2214404407253;14664;17947.371841985532;18324.816751832477;19663.70504442433;19681.311154109626;11773;12037.51849926004;12049.879501204985;17826.554336141602;18086.095695215252;5158.406783219922;5279.313689220396;5281.973590132044;5282.5245727884485;5285.7885684572575;4044.6562042226446;4123.443335149761;4125.195586860564;4126.339785634299;5239.973800130994;5612.186232996213;5795.768169273224;5802.361740208574;5806.216160818299;5806.941930580703;5558.333000039981;5695.8576035599235;5746.482816546489;5755.194272801811;5757.942420575824;5544.22380866679;5551.472610102074;5551.583631227674;5561.972190139064;5566.693831839248;13887.44450222;14322.069065510812;14335.354909029118;14340.713185736227;20721;2153.9892300538554;2448.2532827487607;2462.3967128053564;2540.7840333571667;2577.5231582157176;14120.576382708536;15043.247837608076;15171.848281517154;15549;15630.3747850087;1904.866659333847;1998.060911371653;1999.9100040498213;2116.4603026228215;2130.5525839573706;73239.63380183118;75188.24811751922;76724;76976.23023769747;77779.61110194413;16869.746953795704;16880.49358519222;16924.238409271613;16985.575360615836;17046.573835654206;26802.5979610306;26849.194524164308;26949.326266843487;27058.729412706016;27167.456650866872;8900.643974241088;8979.595918183697;8980.101989800967;9001.774955626162;9045.68340108093;7473.813154671177;7510.84978300431;7545.50954187987;7700.537967721954;7893.1712170222445;8245.216704413071;8304.460210086325;8319;8440.53577053268;8506.362022848187;1947.5423275530238;1951.6194342103154;1970.6748386516065;2365.7870791628834;3124.2355408002977;962.3023308101571;980.4460479828874;1025.4411345816548;1049.8792638846478;1080.2276372393776;16397.42609008703;16809.91595042017;17186.74219886703;17563.648727025644;18998.145083471278;958.9041095890494;959.0505399654431;970.2916870684298;970.4322971061866;1010.3584224017654;8941;9769.951150244204;9783.853242201372;9931.851022234672;10038.598456061676;542949;602596;612291;629569;648833;79818;83811;84194.57902710569;86570.56714716386;87726;1210.2738356985915;1219.1039585904352;1223.3088305107585;1226.2152222577558;1230.0651504856194;16165.4342098026;16191.595210119842;16206.270717817963;16424.753628695817;16644.50066498007;37004.81497592495;37337.81331093327;37488.2502349946;38026.239475210896;39277.80361098176;49874.25188622246;49897.25154122763;49989.75005124951;50875;53947.921041579735;9746.658866939622;9903.55434005486;9953.601855925683;9970.152537034433;9972.351797133164;11556.88443115558;17624.11879405999;18110.90944545269;18385;18412.171452284412;15191.468298609496;15394.307256173275;15418.074915505105;15556.144412057445;15632.609184770472;15146.772798408254;15288.694226115638;15291.158986255863;15379.307931143348;15556.688866222386;15168.620784480476;15478.690426191188;15554.455594054154;15755.921220393824;15920.203989800231;9474.194693451134;9535.046495350409;9548.856767148638;9549.140577348073;9552.95223523878;15057.698846023237;15137.091774493565;15200.619984500476;15218.847811521742;15418.845811541742 04:38:12 INFO - 2016-02-01 04:38:12,616 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1399.195462609;1748.3793253395047;1794.883332583382;1817.8454831339336;1820.781506219253;6978;7721.227877212276;7815.17940616235;7829.882551761714;7835.177306382833;7628.466007379486;7790.493617914832;7854.60726963651;7860.292573668368;7860.489068210562;2289.370423133639;2304.2396009316967;2324.4769926766426;2324.895379707909;2327.4065113396146;2285.925614960974;2327.8137748980125;2331.5336932613545;2332.47519308156;2334.2997100869757;2317.432229103872;2329.895154718033;2342.1568235435316;2346.3782097744024;2375.192434572245;2292.8624282542933;2299.448132448217;2320.0719712115206;2327.3832434404894;2327.7904988551113;2260.2541161416857;2285.5885940530866;2285.725712914461;2285.794278514925;2287.0737351372723;7763.301302882767;7858.960705196495;7869.370450363957;7871.134175240719;7873.448858579902;4698.483166851644;4729.148753224453;4731.905361892777;4760.119377915063;4766.285057241407;3081.383723255358;3093;3150.7951983121025;3159.3207460396125;3178.2372230664705;1044.2690116918188;1055.2349546578669;1067.3809190669392;1081.6965556504392;1094.7755710079414;10553.208509361828;10563.47182640865;10601.098906592948;10638.042576168105;10640.042396184303;4124.401961715595;4178.39413285072;4182.853600124042;4255.914881702349;4298.312270036841;9114.635414583343;9116.49859257734;9130.95434522823;9133.360664753403;9164.95417522908;4627.490975992638;4639.976800115978;4678.95321046792;4699.624030077585;4713.929291060636;3759.285735710206;3781.773093614392;4228.851990180329;4318.417013703172;4326.372675962031;3778.263238668433;3787.5833658297565;3812.561555421162;3838.1939792643857;3842.4044273137706;1162.2851946053286;1169.7368092179192;1177.4760231696812;1184.2124986883798;1203.2599951030054;1329.1493444195723;1333.9599812005656;1343.4156142078032;1347.9932600336936;1348.8516263211038;7384.815379615445;7501.812454688567;7713.730019449293;7724.0731112266885;7739.845203096019;1097.0894157848966;1143.937083460401;1194.1103877611235;1205.270811159236;1205.52984336109;6019.879602408015;6058.636481811105;6066.726997285133;6084.787032453843;6088.543359248074;9113;9428;9500.049995000445;9524.666636667684;9534.189593884597;9343.672971445967;9377.624895004123;9441.339106262496;9503.382280151767;9510.334276600572;7079.327463890922;7343.1555371133;7346.7061317546695;7359.59522226272;7362.153352364439;7133.643317833984;7215.494915356085;7230.023946767329;7245.311695388929;7253.492255542062;8195.344372450309;8245.422820402515;8327.95836020816;8376.664933402595;8401.873971890549;8411.45325553837;8618.61216245283;8627;8630.180132887366;8630.56847157627;6275.560710750204;6394;6609.4712423007;6609.504287178384;6663.833404164935;7579.052618422697;7584.962075189589;7598.772036838904;7620.428467864822;7622.123455802654;7031.964840175767;7200.243974382614;7203.603801790951;7250.3112204340505;7304.086989126359;6894.172699276119;7022.578645281299;7074.080369551925;7146.285371462812;7168.928310716826;6996.685149168198;7104.857902842017;7132;7142.142942846892;7150.964245178949;6646.268910419753;6663.267040625624;6665.566738162004;6684.298148694512;6685.598864068172;6672.232693240146;6681.899771503528;6729.865402691821;6785.050092986887;6786.253512113763 04:38:12 INFO - 2016-02-01 04:38:12,616 DEBUG : BROWSER_OUTPUT: |4;prototype.html;347.56380742168574;349.36241359518885;352.4149911147494;353.6039635608116;359.0932150282001;6103.847403814902;6164.075388691698;6176.567640265183;6198.969005154973;6207;5798.304203495586;5907.970460147704;5968.7314070866805;6063.30272018718;6076.3316035236085;4639.048994956026;4656.906861862761;4660.6970546914345;4673.813047478096;4695.3661255730385;4488.932666010012;4671.27595222741;4691.366665500165;4692.2257827458425;4700.341952126705;4521.186186486431;4571.771411429432;4679.508651591585;4690.624750019991;4699.7415142167165;4680.251159814414;4684.625229981593;4692.53074692528;4699.224627936386;4705.1530724469585;4112.958870411318;4113.691473139526;4114.300568903293;4114.7119701620895;4124.752514849119;5715.142728590703;5779.971100144515;5786.07422812348;5795.797147099874;5801.129830525413;5316.4683531646915;5347;5349.14413693811;5353.357597088336;5354.625176237665;6443.420092191725;6445.258795238514;6446.452051575622;6449.290578036413;6474.805755827286;4432.49026361966;4432.977835110803;4433.578810013044;4434.977825110886;4443.133588950156;6586.571872828251;6646.23568289648;6720.6639668016405;6722.93277067228;6727.966360168168;4564.155631208171;4566.74882881438;4569;4574.08518296342;4576.382188404589;4608.516105808909;4628;4635.397398338195;4637.07258548285;4651.279051746917;5375.408705042442;5379.112446446293;5382.273393091882;5383.327084114486;5390.703511306916;6380.170577824853;6511.218653761579;6529.640869752209;6531.934680653228;6535.3464653534265;1614.6447781488055;1637.582416483789;1641.1630068665067;1644.925978330978;1646.514278287908;1082.967510974672;1090.3839330778085;1090.6727981605486;1101.867775866885;1113.9275947063577;6302.401271879165;6339.746410143634;6340.873182536416;6342.778002769881;6346.714397852108;6459.903101453482;6724.4284235840505;6728.596284222962;6729.25978142404;6731.057651928734;6166.845828854314;6239.313675495692;6326.873462530815;6336.334684858116;6377.8724425512155;3627.365211088049;3632.9818350908076;3633.3823250047553;3662.7985460799378;3672.9632703673155;6836.487263455161;6969.686364113627;6975.82560435983;6986.790396288119;6995.160580730243;6945.0971373721095;6958.617276049866;6958.860822783516;6966;6971.721131154697;6998.265182155902;7010.509264351548;7012.018317435563;7015.684294206773;7016.98253753203;6671.132752742113;6739.123913891162;6780.32196780318;6797.25230224665;6805.285445028201;6676.065350850788;6686.264510903699;6688.899666504909;6696.4977626679165;6699.062131301719;6984.3364880336285;6992.895106573304;6993.510454268152;6999.965000174967;7001.124859392576;4506.887327816831;4586.5872071512385;4592.540745925381;4593.747343895984;4605.654575906753;6777;6791.185057793096;6800.251972283144;6800.319968003358;6804.319568043156;6585.670716464062;6588.868222635425;6597.538172327891;6599.835004124743;6603.240627327918;6363.840903977438;6495.253045899782;6549.574277671936;6564.146660934048;6620.3710647488415;6473.255575608677;6513.250976137805;6519.8044058678315;6526.477881769542;6527.608343499405;6640.070390145287;6649.734010639714;6654.900176497454;6657.600543967377;6665.100211471389;6188.845278868064;6374.90437643445;6386.265579458236;6399.776007839703;6458.806235812933 04:38:12 INFO - 2016-02-01 04:38:12,617 DEBUG : BROWSER_OUTPUT: |5;yui.html;773.9071311442627;860.80631857832;875.4528419737663;882.5322579033115;897.7217062710561;13896.235707036109;14045.578632641038;14160.929195354009;14189.077709948846;14196.432142714291;12880.098393112487;13584.796228056586;13628.93185534071;13657.795133073012;13663.863361366384;761.0942977856361;771.7414666086868;903.2457897655465;906.4742449379377;921.5254144115786;899.4603238057178;900.7703035725914;912.4160537256129;915.6291701860757;916.1113719691888;947.8767760191165;963.8216929867997;968.9321747477679;969.0842154164318;969.7042402067367;941.5151197133482;945.2863088368307;954.1269738189549;955.3837774635322;955.4219697083234;702.3538344722816;708.9751858684921;711.5730561663013;711.5730561663013;712.6579241963834;12720.872791272153;12857.228566286052;12952.611421657366;12972.675683107904;12990.220586764824;12536.686582835411;13022.283774392405;13414.195148291134;13427.127236729679;13502.527411540646;10377.533011014522;10385.688429347132;10425.16598672112;10781.514831832586;10794.622188223375;3691.9815400923094;3773.2830762155104;3787.034306251888;3808.447775072599;3824.1778017726324;45588;45979.77010114962;46795.76602116968;46823;46837;9620.182284505756;10096.798064038825;10275.93616778987;10288.537015834305;10528;18542.53643658892;18593.7210941836;18624.255029798656;18631.347902823338;18692.813071869106;7375.373093287023;7437.479376443597;7548.169701332849;7663.080430348394;7900.209979002054;4319.092990471973;4354.259775838115;4360.454943132108;4401.6478681705385;4425.358323043205;3147.826869522198;3164.145680666207;3173.4129186100645;3175.857086431116;3178.8092714437207;541.7887024060619;557.6932687022122;559.6418292292935;574.7873286883796;580.3905898806321;639.5299454900644;665.8634979829123;687.6424259385092;713.2332742302046;745.0909889934271;8242.216989386;8366.916330836613;8438.535880526508;8552.871706924401;8643.17889800468;705.7388766156555;714.9034880291094;736.6022347932163;756.5082696247373;758.1660173808876;3985.8206380712936;3987.2179147365323;4022.0950286185957;4073.0631954650003;4181.351890456984;55927.72036139793;56259;56439;56461.15308270379;64990.35009649843;48616.27075593869;49418.25872611914;49680.75159624179;49721.502784972414;49931.50068499269;46159.53840461619;46528.767356163;46567.76716116466;46631.300530492066;47361;7899.921000789918;7962.880556791537;8029;8031.718889838828;8432.114627963976;35198.648013520564;35916.64083359238;36316.09209769671;36587;36983.63016369802;43732.56267437285;45257.547424525335;45561.54438455573;47079;47351.28973065476;10666.46667666629;11168;11257.04315133223;11293.943530282297;11360.091192704398;12579.685507862378;12763.87236127664;12830.358482076046;12844.357782111045;13141.145825521311;9781.706548803548;10119.949400252952;10421.843672345072;10509.421981790769;10661.733456663334;10489.737756555842;10630.8405373921;10641.89358106409;10948.726281843017;11288.040516556184;8736.61712710193;8912.688055918012;10412.375257484575;10898.673039808818;11291.209615326849;9797.755056123653;9970.651027214013;10251.128654064489;10279.897201027894;10609.045185932995;8157.34741220689;8225.177482251727;8549.401541892257;8781.736547903573;9015.639374424949 04:38:12 INFO - 2016-02-01 04:38:12,617 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:38:12 INFO - 2016-02-01 04:38:12,618 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:38:12 INFO - 2016-02-01 04:38:12,618 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,654 04:38:12 INFO - 2016-02-01 04:38:12,618 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:38:12 INFO - 2016-02-01 04:38:12,618 DEBUG : BROWSER_OUTPUT: __startTimestamp1454330292611__endTimestamp 04:38:12 INFO - 2016-02-01 04:38:12,618 DEBUG : BROWSER_OUTPUT: 04:38:12 INFO - 2016-02-01 04:38:12,618 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:38:12 INFO - 2016-02-01 04:38:12,618 DEBUG : BROWSER_OUTPUT: Number of tests: 6 04:38:12 INFO - 2016-02-01 04:38:12,618 DEBUG : BROWSER_OUTPUT: 04:38:12 INFO - 2016-02-01 04:38:12,619 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5554.15 Median:5783.65 stddev:618.55 (10.7%) stddev-sans-first:595.17 04:38:12 INFO - 2016-02-01 04:38:12,619 DEBUG : BROWSER_OUTPUT: Values: 3323.0 3355.4 3388.0 3390.5 3410.8 5482.3 5506.0 5540.3 5562.4 5600.0 5563.5 5588.6 5619.1 5621.6 5624.4 4979.4 5037.6 5071.6 5109.7 5173.8 5081.6 5097.0 5097.7 5103.2 5137.7 4887.5 5042.2 5046.3 5105.2 5114.3 5077.9 5159.8 5171.0 5171.9 5175.1 5030.4 5075.5 5137.2 5152.5 5177.5 5230.6 5257.6 5353.5 5356.5 5403.5 5909.1 5999.6 6031.2 6045.5 6061.6 5958.5 6039.4 6084.8 6086.6 6087.6 5444.3 5527.9 5539.9 5618.4 5628.4 6026.1 6124.5 6128.9 6130.2 6155.6 5940.9 5960.0 5967.6 5969.9 5974.2 5857.2 5908.7 5962.6 5978.3 6006.1 5948.5 5962.9 5963.6 5967.2 5967.5 5655.9 5932.9 5969.4 5973.3 5991.4 4479.4 4486.4 4516.8 4518.1 4548.0 4097.5 4102.1 4111.6 4117.3 4129.0 5459.2 5590.0 5667.1 5668.0 5679.9 5937.4 5954.3 5962.8 5988.0 6017.7 5661.1 5760.2 5763.4 5769.2 5783.7 4994.4 5092.7 5219.7 5245.3 5280.3 6201.5 6216.5 6222.1 6226.8 6229.8 6023.8 6031.9 6037.1 6055.3 6055.4 5973.8 6010.1 6099.2 6147.1 6213.1 5884.6 5902.9 5921.5 5927.6 5930.5 6053.0 6055.2 6057.2 6061.2 6064.0 5656.0 5745.3 5776.9 5843.9 5847.0 5843.2 5856.9 5857.2 5871.8 5882.1 5655.5 5788.8 5798.8 5798.9 5800.8 5771.1 5807.6 5858.2 5875.4 5904.4 5676.4 5772.1 5790.2 5835.9 5841.5 04:38:12 INFO - 2016-02-01 04:38:12,619 DEBUG : BROWSER_OUTPUT: 04:38:12 INFO - 2016-02-01 04:38:12,619 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:51808.76 Median:34282.16 stddev:90266.66 (263.3%) stddev-sans-first:90438.03 04:38:12 INFO - 2016-02-01 04:38:12,619 DEBUG : BROWSER_OUTPUT: Values: 610.8 615.8 619.7 632.2 639.4 32222.8 32859.8 40281.2 40546.4 40696.2 44672.8 45111.8 45145.0 45176.0 45271.0 7954.5 8887.0 8952.2 9063.8 9067.5 8082.0 10564.1 10846.5 10855.7 10877.6 10557.9 10645.8 10669.8 10673.1 10678.0 10531.6 10601.0 10624.5 10629.3 10638.1 10309.3 10452.9 10456.1 10457.1 10467.3 42135.6 42665.6 42673.4 42739.8 42768.8 3365.7 3376.5 3455.0 3708.1 3760.0 31626.8 31993.2 31994.5 32005.7 32338.1 4344.2 4355.4 4383.2 4458.2 4458.4 282555.0 284749.0 285102.6 285356.0 287081.0 58957.7 59914.0 63760.7 64062.4 64159.4 77604.0 78076.0 78626.2 78775.6 78780.6 15154.6 15320.2 15329.9 15330.1 15332.2 11491.5 11530.6 11544.2 11571.5 11577.4 21685.8 21919.5 21929.0 22015.6 22016.6 7852.4 8065.8 8093.7 8178.4 8186.6 1012.7 1051.0 1069.6 1147.3 1205.6 29726.9 29917.0 30240.1 30383.8 30464.0 1062.3 1082.3 1128.4 1207.9 1220.6 13149.5 15408.6 15644.0 15955.4 16239.4 339221.0 340586.0 341212.0 342951.0 343343.0 55307.0 55683.0 55824.7 55856.7 55869.7 1332.8 1363.6 1392.1 1406.9 1446.1 26846.3 26919.9 27023.6 27469.2 27580.3 41480.2 41737.8 41800.0 41847.4 44660.6 224639.0 419634.0 425126.0 430808.0 430925.0 34275.0 34693.5 34757.7 34872.0 35049.0 45456.8 45696.8 45830.5 45900.0 46126.3 38730.6 38739.4 38849.2 43922.6 44422.7 38538.8 38605.4 39022.8 39100.8 39264.2 43437.0 43636.0 43726.8 44009.8 44420.0 32748.3 33082.5 34040.8 34289.3 34347.7 26022.6 26793.6 26819.0 26820.9 26983.5 04:38:12 INFO - 2016-02-01 04:38:12,619 DEBUG : BROWSER_OUTPUT: 04:38:12 INFO - 2016-02-01 04:38:12,619 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:32402.44 Median:37171.31 stddev:99393.02 (267.4%) stddev-sans-first:99642.77 04:38:12 INFO - 2016-02-01 04:38:12,621 DEBUG : BROWSER_OUTPUT: Values: 385.7 390.8 391.9 392.1 392.2 14664.0 17947.4 18324.8 19663.7 19681.3 11773.0 12037.5 12049.9 17826.6 18086.1 5158.4 5279.3 5282.0 5282.5 5285.8 4044.7 4123.4 4125.2 4126.3 5240.0 5612.2 5795.8 5802.4 5806.2 5806.9 5558.3 5695.9 5746.5 5755.2 5757.9 5544.2 5551.5 5551.6 5562.0 5566.7 13887.4 14322.1 14335.4 14340.7 20721.0 2154.0 2448.3 2462.4 2540.8 2577.5 14120.6 15043.2 15171.8 15549.0 15630.4 1904.9 1998.1 1999.9 2116.5 2130.6 73239.6 75188.2 76724.0 76976.2 77779.6 16869.7 16880.5 16924.2 16985.6 17046.6 26802.6 26849.2 26949.3 27058.7 27167.5 8900.6 8979.6 8980.1 9001.8 9045.7 7473.8 7510.8 7545.5 7700.5 7893.2 8245.2 8304.5 8319.0 8440.5 8506.4 1947.5 1951.6 1970.7 2365.8 3124.2 962.3 980.4 1025.4 1049.9 1080.2 16397.4 16809.9 17186.7 17563.6 18998.1 958.9 959.1 970.3 970.4 1010.4 8941.0 9770.0 9783.9 9931.9 10038.6 542949.0 602596.0 612291.0 629569.0 648833.0 79818.0 83811.0 84194.6 86570.6 87726.0 1210.3 1219.1 1223.3 1226.2 1230.1 16165.4 16191.6 16206.3 16424.8 16644.5 37004.8 37337.8 37488.3 38026.2 39277.8 49874.3 49897.3 49989.8 50875.0 53947.9 9746.7 9903.6 9953.6 9970.2 9972.4 11556.9 17624.1 18110.9 18385.0 18412.2 15191.5 15394.3 15418.1 15556.1 15632.6 15146.8 15288.7 15291.2 15379.3 15556.7 15168.6 15478.7 15554.5 15755.9 15920.2 9474.2 9535.0 9548.9 9549.1 9553.0 15057.7 15137.1 15200.6 15218.8 15418.8 04:38:12 INFO - 2016-02-01 04:38:12,621 DEBUG : BROWSER_OUTPUT: 04:38:12 INFO - 2016-02-01 04:38:12,621 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5514.44 Median:6334.78 stddev:2812.24 (44.4%) stddev-sans-first:2803.12 04:38:12 INFO - 2016-02-01 04:38:12,622 DEBUG : BROWSER_OUTPUT: Values: 1399.2 1748.4 1794.9 1817.8 1820.8 6978.0 7721.2 7815.2 7829.9 7835.2 7628.5 7790.5 7854.6 7860.3 7860.5 2289.4 2304.2 2324.5 2324.9 2327.4 2285.9 2327.8 2331.5 2332.5 2334.3 2317.4 2329.9 2342.2 2346.4 2375.2 2292.9 2299.4 2320.1 2327.4 2327.8 2260.3 2285.6 2285.7 2285.8 2287.1 7763.3 7859.0 7869.4 7871.1 7873.4 4698.5 4729.1 4731.9 4760.1 4766.3 3081.4 3093.0 3150.8 3159.3 3178.2 1044.3 1055.2 1067.4 1081.7 1094.8 10553.2 10563.5 10601.1 10638.0 10640.0 4124.4 4178.4 4182.9 4255.9 4298.3 9114.6 9116.5 9131.0 9133.4 9165.0 4627.5 4640.0 4679.0 4699.6 4713.9 3759.3 3781.8 4228.9 4318.4 4326.4 3778.3 3787.6 3812.6 3838.2 3842.4 1162.3 1169.7 1177.5 1184.2 1203.3 1329.1 1334.0 1343.4 1348.0 1348.9 7384.8 7501.8 7713.7 7724.1 7739.8 1097.1 1143.9 1194.1 1205.3 1205.5 6019.9 6058.6 6066.7 6084.8 6088.5 9113.0 9428.0 9500.0 9524.7 9534.2 9343.7 9377.6 9441.3 9503.4 9510.3 7079.3 7343.2 7346.7 7359.6 7362.2 7133.6 7215.5 7230.0 7245.3 7253.5 8195.3 8245.4 8328.0 8376.7 8401.9 8411.5 8618.6 8627.0 8630.2 8630.6 6275.6 6394.0 6609.5 6609.5 6663.8 7579.1 7585.0 7598.8 7620.4 7622.1 7032.0 7200.2 7203.6 7250.3 7304.1 6894.2 7022.6 7074.1 7146.3 7168.9 6996.7 7104.9 7132.0 7142.1 7151.0 6646.3 6663.3 6665.6 6684.3 6685.6 6672.2 6681.9 6729.9 6785.1 6786.3 04:38:12 INFO - 2016-02-01 04:38:12,622 DEBUG : BROWSER_OUTPUT: 04:38:12 INFO - 2016-02-01 04:38:12,622 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5446.28 Median:6202.98 stddev:1655.43 (26.7%) stddev-sans-first:1615.24 04:38:12 INFO - 2016-02-01 04:38:12,622 DEBUG : BROWSER_OUTPUT: Values: 347.6 349.4 352.4 353.6 359.1 6103.8 6164.1 6176.6 6199.0 6207.0 5798.3 5908.0 5968.7 6063.3 6076.3 4639.0 4656.9 4660.7 4673.8 4695.4 4488.9 4671.3 4691.4 4692.2 4700.3 4521.2 4571.8 4679.5 4690.6 4699.7 4680.3 4684.6 4692.5 4699.2 4705.2 4113.0 4113.7 4114.3 4114.7 4124.8 5715.1 5780.0 5786.1 5795.8 5801.1 5316.5 5347.0 5349.1 5353.4 5354.6 6443.4 6445.3 6446.5 6449.3 6474.8 4432.5 4433.0 4433.6 4435.0 4443.1 6586.6 6646.2 6720.7 6722.9 6728.0 4564.2 4566.7 4569.0 4574.1 4576.4 4608.5 4628.0 4635.4 4637.1 4651.3 5375.4 5379.1 5382.3 5383.3 5390.7 6380.2 6511.2 6529.6 6531.9 6535.3 1614.6 1637.6 1641.2 1644.9 1646.5 1083.0 1090.4 1090.7 1101.9 1113.9 6302.4 6339.7 6340.9 6342.8 6346.7 6459.9 6724.4 6728.6 6729.3 6731.1 6166.8 6239.3 6326.9 6336.3 6377.9 3627.4 3633.0 3633.4 3662.8 3673.0 6836.5 6969.7 6975.8 6986.8 6995.2 6945.1 6958.6 6958.9 6966.0 6971.7 6998.3 7010.5 7012.0 7015.7 7017.0 6671.1 6739.1 6780.3 6797.3 6805.3 6676.1 6686.3 6688.9 6696.5 6699.1 6984.3 6992.9 6993.5 7000.0 7001.1 4506.9 4586.6 4592.5 4593.7 4605.7 6777.0 6791.2 6800.3 6800.3 6804.3 6585.7 6588.9 6597.5 6599.8 6603.2 6363.8 6495.3 6549.6 6564.1 6620.4 6473.3 6513.3 6519.8 6526.5 6527.6 6640.1 6649.7 6654.9 6657.6 6665.1 6188.8 6374.9 6386.3 6399.8 6458.8 04:38:12 INFO - 2016-02-01 04:38:12,622 DEBUG : BROWSER_OUTPUT: 04:38:12 INFO - 2016-02-01 04:38:12,623 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13780.35 Median:46548.27 stddev:15910.46 (34.2%) stddev-sans-first:15925.11 04:38:12 INFO - 2016-02-01 04:38:12,623 DEBUG : BROWSER_OUTPUT: Values: 773.9 860.8 875.5 882.5 897.7 13896.2 14045.6 14160.9 14189.1 14196.4 12880.1 13584.8 13628.9 13657.8 13663.9 761.1 771.7 903.2 906.5 921.5 899.5 900.8 912.4 915.6 916.1 947.9 963.8 968.9 969.1 969.7 941.5 945.3 954.1 955.4 955.4 702.4 709.0 711.6 711.6 712.7 12720.9 12857.2 12952.6 12972.7 12990.2 12536.7 13022.3 13414.2 13427.1 13502.5 10377.5 10385.7 10425.2 10781.5 10794.6 3692.0 3773.3 3787.0 3808.4 3824.2 45588.0 45979.8 46795.8 46823.0 46837.0 9620.2 10096.8 10275.9 10288.5 10528.0 18542.5 18593.7 18624.3 18631.3 18692.8 7375.4 7437.5 7548.2 7663.1 7900.2 4319.1 4354.3 4360.5 4401.6 4425.4 3147.8 3164.1 3173.4 3175.9 3178.8 541.8 557.7 559.6 574.8 580.4 639.5 665.9 687.6 713.2 745.1 8242.2 8366.9 8438.5 8552.9 8643.2 705.7 714.9 736.6 756.5 758.2 3985.8 3987.2 4022.1 4073.1 4181.4 55927.7 56259.0 56439.0 56461.2 64990.4 48616.3 49418.3 49680.8 49721.5 49931.5 46159.5 46528.8 46567.8 46631.3 47361.0 7899.9 7962.9 8029.0 8031.7 8432.1 35198.6 35916.6 36316.1 36587.0 36983.6 43732.6 45257.5 45561.5 47079.0 47351.3 10666.5 11168.0 11257.0 11293.9 11360.1 12579.7 12763.9 12830.4 12844.4 13141.1 9781.7 10119.9 10421.8 10509.4 10661.7 10489.7 10630.8 10641.9 10948.7 11288.0 8736.6 8912.7 10412.4 10898.7 11291.2 9797.8 9970.7 10251.1 10279.9 10609.0 8157.3 8225.2 8549.4 8781.7 9015.6 04:38:12 INFO - 2016-02-01 04:38:12,623 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:38:12 INFO - 2016-02-01 04:38:12,623 DEBUG : BROWSER_OUTPUT: 04:38:13 INFO - 2016-02-01 04:38:13,196 INFO : Browser exited with error code: 0 04:38:13 INFO - 2016-02-01 04:38:13,216 INFO : Completed test dromaeo_css (00:18:28) 04:38:13 INFO - 2016-02-01 04:38:13,216 INFO : Starting test kraken 04:38:13 INFO - 2016-02-01 04:38:13,217 DEBUG : operating with platform_type : linux_ 04:38:13 INFO - 2016-02-01 04:38:13,217 INFO : Initialising browser for kraken test... 04:38:13 INFO - 2016-02-01 04:38:13,223 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpeozRuk/profile http://localhost:49975/getInfo.html 04:38:16 INFO - 2016-02-01 04:38:16,797 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:38:16 INFO - 2016-02-01 04:38:16,797 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:38:16 INFO - 2016-02-01 04:38:16,797 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:38:16 INFO - 2016-02-01 04:38:16,798 DEBUG : BROWSER_OUTPUT: __metrics 04:38:16 INFO - 2016-02-01 04:38:16,934 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:38:17 INFO - 2016-02-01 04:38:17,492 INFO : Browser initialized. 04:38:17 INFO - 2016-02-01 04:38:17,492 INFO : Running cycle 1/1 for kraken test... 04:38:17 INFO - 2016-02-01 04:38:17,492 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpeozRuk/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:38:29 INFO - 2016-02-01 04:38:29,251 DEBUG : BROWSER_OUTPUT: RSS: Main: 134508544 04:38:29 INFO - 2016-02-01 04:38:29,251 DEBUG : BROWSER_OUTPUT: 04:38:31 INFO - 2016-02-01 04:38:31,659 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49975/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49975/tests/kraken/driver.html?testName=audio-beat-detection) 04:38:32 INFO - 2016-02-01 04:38:32,243 DEBUG : BROWSER_OUTPUT: RSS: Main: 165380096 04:38:32 INFO - 2016-02-01 04:38:32,243 DEBUG : BROWSER_OUTPUT: 04:38:34 INFO - 2016-02-01 04:38:34,800 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49975/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49975/tests/kraken/driver.html?testName=audio-dft) 04:38:35 INFO - 2016-02-01 04:38:35,366 DEBUG : BROWSER_OUTPUT: RSS: Main: 164220928 04:38:35 INFO - 2016-02-01 04:38:35,366 DEBUG : BROWSER_OUTPUT: 04:38:38 INFO - 2016-02-01 04:38:38,115 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49975/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49975/tests/kraken/driver.html?testName=audio-fft) 04:38:38 INFO - 2016-02-01 04:38:38,682 DEBUG : BROWSER_OUTPUT: RSS: Main: 160186368 04:38:38 INFO - 2016-02-01 04:38:38,682 DEBUG : BROWSER_OUTPUT: 04:38:40 INFO - 2016-02-01 04:38:40,634 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49975/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49975/tests/kraken/driver.html?testName=audio-oscillator) 04:38:41 INFO - 2016-02-01 04:38:41,200 DEBUG : BROWSER_OUTPUT: RSS: Main: 161382400 04:38:41 INFO - 2016-02-01 04:38:41,200 DEBUG : BROWSER_OUTPUT: 04:38:43 INFO - 2016-02-01 04:38:43,375 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49975/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49975/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:38:43 INFO - 2016-02-01 04:38:43,935 DEBUG : BROWSER_OUTPUT: RSS: Main: 158810112 04:38:43 INFO - 2016-02-01 04:38:43,936 DEBUG : BROWSER_OUTPUT: 04:38:46 INFO - 2016-02-01 04:38:46,787 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49975/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49975/tests/kraken/driver.html?testName=imaging-darkroom) 04:38:47 INFO - 2016-02-01 04:38:47,361 DEBUG : BROWSER_OUTPUT: RSS: Main: 159141888 04:38:47 INFO - 2016-02-01 04:38:47,362 DEBUG : BROWSER_OUTPUT: 04:38:50 INFO - 2016-02-01 04:38:50,683 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49975/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49975/tests/kraken/driver.html?testName=imaging-desaturate) 04:38:51 INFO - 2016-02-01 04:38:51,249 DEBUG : BROWSER_OUTPUT: RSS: Main: 161021952 04:38:51 INFO - 2016-02-01 04:38:51,250 DEBUG : BROWSER_OUTPUT: 04:38:54 INFO - 2016-02-01 04:38:54,008 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49975/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49975/tests/kraken/driver.html?testName=json-parse-financial) 04:38:54 INFO - 2016-02-01 04:38:54,574 DEBUG : BROWSER_OUTPUT: RSS: Main: 160604160 04:38:54 INFO - 2016-02-01 04:38:54,574 DEBUG : BROWSER_OUTPUT: 04:38:56 INFO - 2016-02-01 04:38:56,095 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49975/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49975/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:38:56 INFO - 2016-02-01 04:38:56,650 DEBUG : BROWSER_OUTPUT: RSS: Main: 164597760 04:38:56 INFO - 2016-02-01 04:38:56,650 DEBUG : BROWSER_OUTPUT: 04:38:58 INFO - 2016-02-01 04:38:58,380 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49975/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49975/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:38:58 INFO - 2016-02-01 04:38:58,973 DEBUG : BROWSER_OUTPUT: RSS: Main: 162938880 04:38:58 INFO - 2016-02-01 04:38:58,974 DEBUG : BROWSER_OUTPUT: 04:39:00 INFO - 2016-02-01 04:39:00,913 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49975/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49975/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:39:01 INFO - 2016-02-01 04:39:01,483 DEBUG : BROWSER_OUTPUT: RSS: Main: 167579648 04:39:01 INFO - 2016-02-01 04:39:01,483 DEBUG : BROWSER_OUTPUT: 04:39:03 INFO - 2016-02-01 04:39:03,870 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49975/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49975/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:39:04 INFO - 2016-02-01 04:39:04,452 DEBUG : BROWSER_OUTPUT: RSS: Main: 174104576 04:39:04 INFO - 2016-02-01 04:39:04,452 DEBUG : BROWSER_OUTPUT: 04:39:06 INFO - 2016-02-01 04:39:06,915 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49975/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49975/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:39:07 INFO - 2016-02-01 04:39:07,484 DEBUG : BROWSER_OUTPUT: RSS: Main: 171913216 04:39:07 INFO - 2016-02-01 04:39:07,484 DEBUG : BROWSER_OUTPUT: 04:39:09 INFO - 2016-02-01 04:39:09,126 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49975/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49975/tests/kraken/driver.html?testName=ai-astar) 04:39:09 INFO - 2016-02-01 04:39:09,376 DEBUG : BROWSER_OUTPUT: RSS: Main: 229969920 04:39:09 INFO - 2016-02-01 04:39:09,376 DEBUG : BROWSER_OUTPUT: 04:39:09 INFO - 2016-02-01 04:39:09,376 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:39:09 INFO - 2016-02-01 04:39:09,377 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:39:09 INFO - 2016-02-01 04:39:09,377 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:39:09 INFO - 2016-02-01 04:39:09,377 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:39:09 INFO - 2016-02-01 04:39:09,378 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;111;105;109;110;110;99;110;110;109 04:39:09 INFO - 2016-02-01 04:39:09,378 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;144;122;144;160;125;151;148;121;158;125 04:39:09 INFO - 2016-02-01 04:39:09,378 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;160;159;160;160;161;159;162;160;159 04:39:09 INFO - 2016-02-01 04:39:09,378 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;71;71;149;70;74;72;72;149;72 04:39:09 INFO - 2016-02-01 04:39:09,379 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;93;144;92;93;93;136;92;94;138 04:39:09 INFO - 2016-02-01 04:39:09,379 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;109;110;109;109;109;109;109;109 04:39:09 INFO - 2016-02-01 04:39:09,379 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;145;146;146;144;145;145;145;145;144 04:39:09 INFO - 2016-02-01 04:39:09,380 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;96;95;96;97;95;95;95;94 04:39:09 INFO - 2016-02-01 04:39:09,380 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;55;55;56;56;55;55;56;54;53;55 04:39:09 INFO - 2016-02-01 04:39:09,380 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;63;63;64;64;64;63;64;64;64;64 04:39:09 INFO - 2016-02-01 04:39:09,380 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;77;76;78;77;77;77;78;77;78;77 04:39:09 INFO - 2016-02-01 04:39:09,381 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;114;124;115;119;118;114;117;118;127;116 04:39:09 INFO - 2016-02-01 04:39:09,381 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;135;147;141;139;148;144;142;142;142;132 04:39:09 INFO - 2016-02-01 04:39:09,381 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;64;65;63;64;64;62;64;65;64;65 04:39:09 INFO - 2016-02-01 04:39:09,382 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:39:09 INFO - 2016-02-01 04:39:09,382 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:39:09 INFO - 2016-02-01 04:39:09,382 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,889 04:39:09 INFO - 2016-02-01 04:39:09,382 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:39:09 INFO - 2016-02-01 04:39:09,384 DEBUG : BROWSER_OUTPUT: __startTimestamp1454330349375__endTimestamp 04:39:09 INFO - 2016-02-01 04:39:09,384 DEBUG : BROWSER_OUTPUT: 04:39:09 INFO - 2016-02-01 04:39:09,384 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:39:09 INFO - 2016-02-01 04:39:09,384 DEBUG : BROWSER_OUTPUT: Number of tests: 14 04:39:09 INFO - 2016-02-01 04:39:09,384 DEBUG : BROWSER_OUTPUT: 04:39:09 INFO - 2016-02-01 04:39:09,384 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.20 Median:110.00 stddev:3.61 (3.3%) stddev-sans-first:3.82 04:39:09 INFO - 2016-02-01 04:39:09,384 DEBUG : BROWSER_OUTPUT: Values: 109.0 111.0 105.0 109.0 110.0 110.0 99.0 110.0 110.0 109.0 04:39:09 INFO - 2016-02-01 04:39:09,385 DEBUG : BROWSER_OUTPUT: 04:39:09 INFO - 2016-02-01 04:39:09,385 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:139.80 Median:146.00 stddev:15.19 (10.4%) stddev-sans-first:16.03 04:39:09 INFO - 2016-02-01 04:39:09,385 DEBUG : BROWSER_OUTPUT: Values: 144.0 122.0 144.0 160.0 125.0 151.0 148.0 121.0 158.0 125.0 04:39:09 INFO - 2016-02-01 04:39:09,385 DEBUG : BROWSER_OUTPUT: 04:39:09 INFO - 2016-02-01 04:39:09,385 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.00 Median:160.00 stddev:0.94 (0.6%) stddev-sans-first:1.00 04:39:09 INFO - 2016-02-01 04:39:09,385 DEBUG : BROWSER_OUTPUT: Values: 160.0 160.0 159.0 160.0 160.0 161.0 159.0 162.0 160.0 159.0 04:39:09 INFO - 2016-02-01 04:39:09,385 DEBUG : BROWSER_OUTPUT: 04:39:09 INFO - 2016-02-01 04:39:09,385 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:87.10 Median:71.50 stddev:32.64 (45.7%) stddev-sans-first:34.10 04:39:09 INFO - 2016-02-01 04:39:09,386 DEBUG : BROWSER_OUTPUT: Values: 71.0 71.0 71.0 149.0 70.0 74.0 72.0 72.0 149.0 72.0 04:39:09 INFO - 2016-02-01 04:39:09,386 DEBUG : BROWSER_OUTPUT: 04:39:09 INFO - 2016-02-01 04:39:09,386 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.80 Median:93.00 stddev:22.54 (24.2%) stddev-sans-first:23.35 04:39:09 INFO - 2016-02-01 04:39:09,386 DEBUG : BROWSER_OUTPUT: Values: 93.0 93.0 144.0 92.0 93.0 93.0 136.0 92.0 94.0 138.0 04:39:09 INFO - 2016-02-01 04:39:09,386 DEBUG : BROWSER_OUTPUT: 04:39:09 INFO - 2016-02-01 04:39:09,386 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 04:39:09 INFO - 2016-02-01 04:39:09,386 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 109.0 110.0 109.0 109.0 109.0 109.0 109.0 109.0 04:39:09 INFO - 2016-02-01 04:39:09,386 DEBUG : BROWSER_OUTPUT: 04:39:09 INFO - 2016-02-01 04:39:09,386 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.00 Median:145.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 04:39:09 INFO - 2016-02-01 04:39:09,387 DEBUG : BROWSER_OUTPUT: Values: 145.0 145.0 146.0 146.0 144.0 145.0 145.0 145.0 145.0 144.0 04:39:09 INFO - 2016-02-01 04:39:09,387 DEBUG : BROWSER_OUTPUT: 04:39:09 INFO - 2016-02-01 04:39:09,387 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.84 (0.9%) stddev-sans-first:0.87 04:39:09 INFO - 2016-02-01 04:39:09,387 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 96.0 95.0 96.0 97.0 95.0 95.0 95.0 94.0 04:39:09 INFO - 2016-02-01 04:39:09,387 DEBUG : BROWSER_OUTPUT: 04:39:09 INFO - 2016-02-01 04:39:09,387 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:55.00 Median:55.00 stddev:0.94 (1.7%) stddev-sans-first:1.00 04:39:09 INFO - 2016-02-01 04:39:09,387 DEBUG : BROWSER_OUTPUT: Values: 55.0 55.0 56.0 56.0 55.0 55.0 56.0 54.0 53.0 55.0 04:39:09 INFO - 2016-02-01 04:39:09,387 DEBUG : BROWSER_OUTPUT: 04:39:09 INFO - 2016-02-01 04:39:09,387 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:63.70 Median:64.00 stddev:0.48 (0.8%) stddev-sans-first:0.44 04:39:09 INFO - 2016-02-01 04:39:09,388 DEBUG : BROWSER_OUTPUT: Values: 63.0 63.0 64.0 64.0 64.0 63.0 64.0 64.0 64.0 64.0 04:39:09 INFO - 2016-02-01 04:39:09,388 DEBUG : BROWSER_OUTPUT: 04:39:09 INFO - 2016-02-01 04:39:09,388 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:77.20 Median:77.00 stddev:0.63 (0.8%) stddev-sans-first:0.67 04:39:09 INFO - 2016-02-01 04:39:09,388 DEBUG : BROWSER_OUTPUT: Values: 77.0 76.0 78.0 77.0 77.0 77.0 78.0 77.0 78.0 77.0 04:39:09 INFO - 2016-02-01 04:39:09,388 DEBUG : BROWSER_OUTPUT: 04:39:09 INFO - 2016-02-01 04:39:09,388 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:118.20 Median:118.00 stddev:4.26 (3.6%) stddev-sans-first:4.24 04:39:09 INFO - 2016-02-01 04:39:09,388 DEBUG : BROWSER_OUTPUT: Values: 114.0 124.0 115.0 119.0 118.0 114.0 117.0 118.0 127.0 116.0 04:39:09 INFO - 2016-02-01 04:39:09,388 DEBUG : BROWSER_OUTPUT: 04:39:09 INFO - 2016-02-01 04:39:09,388 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.20 Median:142.00 stddev:4.92 (3.5%) stddev-sans-first:4.68 04:39:09 INFO - 2016-02-01 04:39:09,389 DEBUG : BROWSER_OUTPUT: Values: 135.0 147.0 141.0 139.0 148.0 144.0 142.0 142.0 142.0 132.0 04:39:09 INFO - 2016-02-01 04:39:09,389 DEBUG : BROWSER_OUTPUT: 04:39:09 INFO - 2016-02-01 04:39:09,389 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.00 Median:64.00 stddev:0.94 (1.5%) stddev-sans-first:1.00 04:39:09 INFO - 2016-02-01 04:39:09,389 DEBUG : BROWSER_OUTPUT: Values: 64.0 65.0 63.0 64.0 64.0 62.0 64.0 65.0 64.0 65.0 04:39:09 INFO - 2016-02-01 04:39:09,389 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:39:09 INFO - 2016-02-01 04:39:09,389 DEBUG : BROWSER_OUTPUT: 04:39:10 INFO - 2016-02-01 04:39:10,020 INFO : Browser exited with error code: 0 04:39:10 INFO - 2016-02-01 04:39:10,070 INFO : Completed test kraken (00:00:56) 04:39:10 INFO - 2016-02-01 04:39:10,070 INFO : Starting test v8_7 04:39:10 INFO - 2016-02-01 04:39:10,070 DEBUG : operating with platform_type : linux_ 04:39:10 INFO - 2016-02-01 04:39:10,070 INFO : Initialising browser for v8_7 test... 04:39:10 INFO - 2016-02-01 04:39:10,077 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpLmf4yQ/profile http://localhost:49975/getInfo.html 04:39:13 INFO - 2016-02-01 04:39:13,554 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:39:13 INFO - 2016-02-01 04:39:13,554 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:39:13 INFO - 2016-02-01 04:39:13,554 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:39:13 INFO - 2016-02-01 04:39:13,554 DEBUG : BROWSER_OUTPUT: __metrics 04:39:13 INFO - 2016-02-01 04:39:13,671 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:39:14 INFO - 2016-02-01 04:39:14,246 INFO : Browser initialized. 04:39:14 INFO - 2016-02-01 04:39:14,246 INFO : Running cycle 1/1 for v8_7 test... 04:39:14 INFO - 2016-02-01 04:39:14,246 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpLmf4yQ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:39:26 INFO - 2016-02-01 04:39:26,002 DEBUG : BROWSER_OUTPUT: RSS: Main: 134324224 04:39:26 INFO - 2016-02-01 04:39:26,003 DEBUG : BROWSER_OUTPUT: 04:39:47 INFO - 2016-02-01 04:39:47,349 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49975/tests/v8_7/run.html (next: http://localhost:49975/tests/v8_7/run.html) 04:39:47 INFO - 2016-02-01 04:39:47,596 DEBUG : BROWSER_OUTPUT: RSS: Main: 421187584 04:39:47 INFO - 2016-02-01 04:39:47,596 DEBUG : BROWSER_OUTPUT: 04:39:47 INFO - 2016-02-01 04:39:47,597 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:39:47 INFO - 2016-02-01 04:39:47,597 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:39:47 INFO - 2016-02-01 04:39:47,598 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:39:47 INFO - 2016-02-01 04:39:47,598 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:39:47 INFO - 2016-02-01 04:39:47,598 DEBUG : BROWSER_OUTPUT: |0;Richards;167.25204883759827 04:39:47 INFO - 2016-02-01 04:39:47,598 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;166.6944490748458 04:39:47 INFO - 2016-02-01 04:39:47,598 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.662363177098 04:39:47 INFO - 2016-02-01 04:39:47,599 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5164.948453608247 04:39:47 INFO - 2016-02-01 04:39:47,599 DEBUG : BROWSER_OUTPUT: |4;RayTrace;960.6147934678194 04:39:47 INFO - 2016-02-01 04:39:47,599 DEBUG : BROWSER_OUTPUT: |5;Earley;544.069640914037 04:39:47 INFO - 2016-02-01 04:39:47,599 DEBUG : BROWSER_OUTPUT: |6;Boyer;10648.936170212766 04:39:47 INFO - 2016-02-01 04:39:47,600 DEBUG : BROWSER_OUTPUT: |7;RegExp;23880.95238095238 04:39:47 INFO - 2016-02-01 04:39:47,600 DEBUG : BROWSER_OUTPUT: |8;Splay;524.9739854318418 04:39:47 INFO - 2016-02-01 04:39:47,600 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4822.115384615385 04:39:47 INFO - 2016-02-01 04:39:47,600 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:39:47 INFO - 2016-02-01 04:39:47,600 DEBUG : BROWSER_OUTPUT: __startTimestamp1454330387596__endTimestamp 04:39:47 INFO - 2016-02-01 04:39:47,601 DEBUG : BROWSER_OUTPUT: 04:39:47 INFO - 2016-02-01 04:39:47,601 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:39:47 INFO - 2016-02-01 04:39:47,601 DEBUG : BROWSER_OUTPUT: Number of tests: 10 04:39:47 INFO - 2016-02-01 04:39:47,601 DEBUG : BROWSER_OUTPUT: 04:39:47 INFO - 2016-02-01 04:39:47,602 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:167.25 Median:167.25 stddev:0.00 (0.0%) 04:39:47 INFO - 2016-02-01 04:39:47,602 DEBUG : BROWSER_OUTPUT: Values: 167.3 04:39:47 INFO - 2016-02-01 04:39:47,602 DEBUG : BROWSER_OUTPUT: 04:39:47 INFO - 2016-02-01 04:39:47,602 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:166.69 Median:166.69 stddev:0.00 (0.0%) 04:39:47 INFO - 2016-02-01 04:39:47,604 DEBUG : BROWSER_OUTPUT: Values: 166.7 04:39:47 INFO - 2016-02-01 04:39:47,604 DEBUG : BROWSER_OUTPUT: 04:39:47 INFO - 2016-02-01 04:39:47,604 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.66 Median:280.66 stddev:0.00 (0.0%) 04:39:47 INFO - 2016-02-01 04:39:47,604 DEBUG : BROWSER_OUTPUT: Values: 280.7 04:39:47 INFO - 2016-02-01 04:39:47,604 DEBUG : BROWSER_OUTPUT: 04:39:47 INFO - 2016-02-01 04:39:47,605 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5164.95 Median:5164.95 stddev:0.00 (0.0%) 04:39:47 INFO - 2016-02-01 04:39:47,605 DEBUG : BROWSER_OUTPUT: Values: 5164.9 04:39:47 INFO - 2016-02-01 04:39:47,605 DEBUG : BROWSER_OUTPUT: 04:39:47 INFO - 2016-02-01 04:39:47,605 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:960.61 Median:960.61 stddev:0.00 (0.0%) 04:39:47 INFO - 2016-02-01 04:39:47,605 DEBUG : BROWSER_OUTPUT: Values: 960.6 04:39:47 INFO - 2016-02-01 04:39:47,605 DEBUG : BROWSER_OUTPUT: 04:39:47 INFO - 2016-02-01 04:39:47,605 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:544.07 Median:544.07 stddev:0.00 (0.0%) 04:39:47 INFO - 2016-02-01 04:39:47,606 DEBUG : BROWSER_OUTPUT: Values: 544.1 04:39:47 INFO - 2016-02-01 04:39:47,606 DEBUG : BROWSER_OUTPUT: 04:39:47 INFO - 2016-02-01 04:39:47,606 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10648.94 Median:10648.94 stddev:0.00 (0.0%) 04:39:47 INFO - 2016-02-01 04:39:47,606 DEBUG : BROWSER_OUTPUT: Values: 10648.9 04:39:47 INFO - 2016-02-01 04:39:47,606 DEBUG : BROWSER_OUTPUT: 04:39:47 INFO - 2016-02-01 04:39:47,606 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:23880.95 Median:23880.95 stddev:0.00 (0.0%) 04:39:47 INFO - 2016-02-01 04:39:47,607 DEBUG : BROWSER_OUTPUT: Values: 23881.0 04:39:47 INFO - 2016-02-01 04:39:47,607 DEBUG : BROWSER_OUTPUT: 04:39:47 INFO - 2016-02-01 04:39:47,607 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:524.97 Median:524.97 stddev:0.00 (0.0%) 04:39:47 INFO - 2016-02-01 04:39:47,607 DEBUG : BROWSER_OUTPUT: Values: 525.0 04:39:47 INFO - 2016-02-01 04:39:47,607 DEBUG : BROWSER_OUTPUT: 04:39:47 INFO - 2016-02-01 04:39:47,607 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 04:39:47 INFO - 2016-02-01 04:39:47,607 DEBUG : BROWSER_OUTPUT: Values: 4822.1 04:39:47 INFO - 2016-02-01 04:39:47,607 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:39:47 INFO - 2016-02-01 04:39:47,607 DEBUG : BROWSER_OUTPUT: 04:39:48 INFO - 2016-02-01 04:39:48,236 INFO : Browser exited with error code: 0 04:39:48 INFO - 2016-02-01 04:39:48,252 INFO : Completed test v8_7 (00:00:38) 04:39:48 INFO - 2016-02-01 04:39:48,629 INFO : Completed test suite (00:20:04) 04:39:48 INFO - 2016-02-01 04:39:48,629 DEBUG : Working with test: dromaeo_css 04:39:48 INFO - 2016-02-01 04:39:48,629 DEBUG : Generating results file: dromaeo_css 04:39:48 INFO - 2016-02-01 04:39:48,630 DEBUG : Working with test: kraken 04:39:48 INFO - 2016-02-01 04:39:48,631 DEBUG : Generating results file: kraken 04:39:48 INFO - 2016-02-01 04:39:48,631 INFO : javascript benchmark 04:39:48 INFO - 2016-02-01 04:39:48,631 DEBUG : Working with test: v8_7 04:39:48 INFO - 2016-02-01 04:39:48,631 DEBUG : Generating results file: v8_7 04:39:48 INFO - 2016-02-01 04:39:48,632 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:39:48 INFO - 2016-02-01 04:39:48,700 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,53,35]] 04:39:48 INFO - 2016-02-01 04:39:48,700 DEBUG : process_Request line: dromaeo_css 7347.56 graph.html#tests=[[72,53,35]] 04:39:48 INFO - 2016-02-01 04:39:48,700 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:39:48 INFO - 2016-02-01 04:39:48,730 DEBUG : process_Request line: kraken 1470.80 graph.html#tests=[[232,53,35]] 04:39:48 INFO - 2016-02-01 04:39:48,730 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:39:48 INFO - 2016-02-01 04:39:48,852 DEBUG : process_Request line: v8_7 23229.28 graph.html#tests=[[230,53,35]] 04:39:48 INFO - 2016-02-01 04:39:48,853 INFO : javascript benchmark 04:39:48 INFO - 2016-02-01 04:39:48,857 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3323.0, 3355.3960287148334, 3387.983060084701, 3390.457526795713, 3410.7612467127296, 5482.287302650655, 5505.9724701376535, 5540.335159780827, 5562.44375562444, 5600.0, 5563.527100196488, 5588.580856435773, 5619.072852979264, 5621.606487545873, 5624.3531993820625, 4979.427365852937, 5037.622178336621, 5071.594272458204, 5109.667871588354, 5173.767180476869, 5081.64428490004, 5097.0, 5097.668651537657, 5103.234514822788, 5137.717425541594, 4887.535684110022, 5042.193249080129, 5046.3187469691675, 5105.208692652626, 5114.28400023997, 5077.873053173664, 5159.76781044852, 5170.97414512925, 5171.870703232412, 5175.146100893348, 5030.4215015272985, 5075.492450754932, 5137.229415587654, 5152.4847515248175, 5177.534021938043, 5230.633855630107, 5257.553107985826, 5353.544948679367, 5356.491133342326, 5403.540699040586, 5909.084091965752, 5999.580029397944, 6031.215941927521, 6045.45590896817, 6061.605995610315, 5958.463738263577, 6039.3960603939695, 6084.847878803065, 6086.573939824214, 6087.634741915455, 5444.346678398578, 5527.944720552783, 5539.861503462405, 5618.353889302701, 5628.380878103405, 6026.0659597762415, 6124.540659450559, 6128.938710612926, 6130.203073600493, 6155.599886007395, 5940.8811823764145, 5960.0, 5967.6121052131475, 5969.940300597025, 5974.1934838796205, 5857.179994800731, 5908.675022873697, 5962.612430192024, 5978.3124940631515, 6006.129111278928, 5948.464638182584, 5962.940370596239, 5963.612365196248, 5967.16459695643, 5967.522598192134, 5655.886882262332, 5932.8813423732145, 5969.403059694083, 5973.313068997121, 5991.430814072656, 4479.417675702203, 4486.371907932892, 4516.796744146522, 4518.1415531049, 4547.954520454753, 4097.528784189856, 4102.056526998807, 4111.568285329998, 4117.3206420940805, 4128.958710412858, 5459.208414779835, 5590.049691552445, 5667.121596152603, 5667.979763642584, 5679.886402271932, 5937.435943585352, 5954.3152537458745, 5962.761489540457, 5987.970060149759, 6017.729202185912, 5661.094224923992, 5760.193572899798, 5763.423657634287, 5769.1634712967225, 5783.652980821164, 4994.375703037121, 5092.694438333638, 5219.686818790885, 5245.318108645852, 5280.260763493114, 6201.472874805602, 6216.471599914058, 6222.097795819581, 6226.750929962841, 6229.7508099676415, 6023.759049637965, 6031.879362412815, 6037.09443583466, 6055.333913269625, 6055.3987561504555, 5973.790917317873, 6010.068439391901, 6099.207103076572, 6147.108669243024, 6213.068039793886, 5884.58807883444, 5902.911456328245, 5921.496672782861, 5927.585069045125, 5930.466258036798, 6052.969735151296, 6055.182550355646, 6057.212562366864, 6061.1514387984835, 6063.9696801517475, 5656.010198215214, 5745.339285982165, 5776.942230577641, 5843.94156058434, 5847.035239185487, 5843.152742852178, 5856.94143058564, 5857.150713146485, 5871.7651293947765, 5882.1470886722045, 5655.519280861173, 5788.82633520995, 5798.797042103675, 5798.94201057984, 5800.8259752207505, 5771.076627739541, 5807.564432667651, 5858.238429004202, 5875.441833025856, 5904.439078287556, 5676.375598684059, 5772.134179873053, 5790.1893734877995, 5835.94164058354, 5841.50347220491], "unit": "ms", "name": "dojo.html", "value": 5514.088117122301}, {"lowerIsBetter": false, "replicates": [610.8075956073836, 615.7783198048702, 619.6994457688021, 632.2318383164455, 639.3893831391022, 32222.838885805566, 32859.835700821495, 40281.19437611246, 40546.39180412296, 40696.186076278456, 44672.776636116774, 45111.774441127745, 45145.0, 45176.0, 45271.0, 7954.482958607701, 8887.022427532982, 8952.194302512773, 9063.773405664846, 9067.546622668873, 8082.0, 10564.102051325608, 10846.457677116112, 10855.67432977012, 10877.619283325084, 10557.894421055806, 10645.840312395281, 10669.83995240072, 10673.146148308155, 10678.038976492115, 10531.578736850555, 10601.04590586847, 10624.521896514676, 10629.255952083357, 10638.148948084136, 10309.32989355697, 10452.947735261276, 10456.058954694114, 10457.111145552637, 10467.267291289612, 42135.57864421347, 42665.57334426647, 42673.35989960153, 42739.78630106829, 42768.78615606902, 3365.7139143172617, 3376.5441665375106, 3454.9654503454894, 3708.0915175782106, 3759.981200094009, 31626.841865790753, 31993.200169995936, 31994.520082198786, 32005.679943200736, 32338.119425668836, 4344.174606824725, 4355.433793606842, 4383.189110014626, 4458.197524445599, 4458.398116254329, 282555.0, 284749.0, 285102.5744871283, 285356.0, 287081.0, 58957.705211474524, 59914.0, 63760.68119659465, 64062.35937640657, 64159.35840641627, 77604.0, 78076.0, 78626.21373786303, 78775.60612196902, 78780.6060969703, 15154.621134471727, 15320.157391343582, 15329.9233503834, 15330.080195188324, 15332.233388330538, 11491.540338386538, 11530.59642912494, 11544.191906566628, 11571.479283432265, 11577.421128943688, 21685.783142168377, 21919.452013699785, 21929.0, 22015.559688806134, 22016.559668806534, 7852.371810255166, 8065.838683226302, 8093.716719914774, 8178.446095241885, 8186.590670466453, 1012.7012531303136, 1050.9527071281811, 1069.5614797932965, 1147.2944139354238, 1205.5539450403407, 29726.851365743034, 29917.0, 30240.09279721612, 30383.848080759453, 30464.0, 1062.3483070067323, 1082.2910993299402, 1128.3568366031448, 1207.9033677305795, 1220.5911019808464, 13149.474021039052, 15408.61478463025, 15644.0, 15955.361785528681, 16239.431619893483, 339221.0, 340586.0, 341212.0, 342951.0, 343343.0, 55307.0, 55683.0, 55824.72087639536, 55856.72071639697, 55869.720651396485, 1332.7734285171543, 1363.604554679132, 1392.1160063359637, 1406.859314068585, 1446.1250943179436, 26846.32884177833, 26919.865400672872, 27023.59464607993, 27469.17592472229, 27580.310492237855, 41480.170396592504, 41737.79131104325, 41800.0, 41847.37228941507, 44660.55339446694, 224639.0, 419634.0, 425126.0, 430808.0, 430925.0, 34275.0, 34693.47959780555, 34757.65242347544, 34872.0, 35049.0, 45456.772716136205, 45696.77151614221, 45830.54169458263, 45900.0, 46126.30810537777, 38730.6126938727, 38739.41890871583, 38849.22301553896, 43922.560774391844, 44422.66927968664, 38538.80730596329, 38605.4209186868, 39022.80488597539, 39100.80449597734, 39264.2147157061, 43437.0, 43636.0, 43726.78136609297, 44009.77995110132, 44420.0, 32748.345033099682, 33082.50376244407, 34040.82979585086, 34289.31421371608, 34347.656523434445, 26022.60966085548, 26793.598096028963, 26819.040781016716, 26820.865895671177, 26983.460330793667], "unit": "ms", "name": "ext.html", "value": 20004.02874426738}, {"lowerIsBetter": false, "replicates": [385.6721786481491, 390.78116254897253, 391.86359557283873, 392.0825268870845, 392.2214404407253, 14664.0, 17947.371841985532, 18324.816751832477, 19663.70504442433, 19681.311154109626, 11773.0, 12037.51849926004, 12049.879501204985, 17826.554336141602, 18086.095695215252, 5158.406783219922, 5279.313689220396, 5281.973590132044, 5282.5245727884485, 5285.7885684572575, 4044.6562042226446, 4123.443335149761, 4125.195586860564, 4126.339785634299, 5239.973800130994, 5612.186232996213, 5795.768169273224, 5802.361740208574, 5806.216160818299, 5806.941930580703, 5558.333000039981, 5695.8576035599235, 5746.482816546489, 5755.194272801811, 5757.942420575824, 5544.22380866679, 5551.472610102074, 5551.583631227674, 5561.972190139064, 5566.693831839248, 13887.44450222, 14322.069065510812, 14335.354909029118, 14340.713185736227, 20721.0, 2153.9892300538554, 2448.2532827487607, 2462.3967128053564, 2540.7840333571667, 2577.5231582157176, 14120.576382708536, 15043.247837608076, 15171.848281517154, 15549.0, 15630.3747850087, 1904.866659333847, 1998.060911371653, 1999.9100040498213, 2116.4603026228215, 2130.5525839573706, 73239.63380183118, 75188.24811751922, 76724.0, 76976.23023769747, 77779.61110194413, 16869.746953795704, 16880.49358519222, 16924.238409271613, 16985.575360615836, 17046.573835654206, 26802.5979610306, 26849.194524164308, 26949.326266843487, 27058.729412706016, 27167.456650866872, 8900.643974241088, 8979.595918183697, 8980.101989800967, 9001.774955626162, 9045.68340108093, 7473.813154671177, 7510.84978300431, 7545.50954187987, 7700.537967721954, 7893.1712170222445, 8245.216704413071, 8304.460210086325, 8319.0, 8440.53577053268, 8506.362022848187, 1947.5423275530238, 1951.6194342103154, 1970.6748386516065, 2365.7870791628834, 3124.2355408002977, 962.3023308101571, 980.4460479828874, 1025.4411345816548, 1049.8792638846478, 1080.2276372393776, 16397.42609008703, 16809.91595042017, 17186.74219886703, 17563.648727025644, 18998.145083471278, 958.9041095890494, 959.0505399654431, 970.2916870684298, 970.4322971061866, 1010.3584224017654, 8941.0, 9769.951150244204, 9783.853242201372, 9931.851022234672, 10038.598456061676, 542949.0, 602596.0, 612291.0, 629569.0, 648833.0, 79818.0, 83811.0, 84194.57902710569, 86570.56714716386, 87726.0, 1210.2738356985915, 1219.1039585904352, 1223.3088305107585, 1226.2152222577558, 1230.0651504856194, 16165.4342098026, 16191.595210119842, 16206.270717817963, 16424.753628695817, 16644.50066498007, 37004.81497592495, 37337.81331093327, 37488.2502349946, 38026.239475210896, 39277.80361098176, 49874.25188622246, 49897.25154122763, 49989.75005124951, 50875.0, 53947.921041579735, 9746.658866939622, 9903.55434005486, 9953.601855925683, 9970.152537034433, 9972.351797133164, 11556.88443115558, 17624.11879405999, 18110.90944545269, 18385.0, 18412.171452284412, 15191.468298609496, 15394.307256173275, 15418.074915505105, 15556.144412057445, 15632.609184770472, 15146.772798408254, 15288.694226115638, 15291.158986255863, 15379.307931143348, 15556.688866222386, 15168.620784480476, 15478.690426191188, 15554.455594054154, 15755.921220393824, 15920.203989800231, 9474.194693451134, 9535.046495350409, 9548.856767148638, 9549.140577348073, 9552.95223523878, 15057.698846023237, 15137.091774493565, 15200.619984500476, 15218.847811521742, 15418.845811541742], "unit": "ms", "name": "jquery.html", "value": 9881.47658726471}, {"lowerIsBetter": false, "replicates": [1399.195462609, 1748.3793253395047, 1794.883332583382, 1817.8454831339336, 1820.781506219253, 6978.0, 7721.227877212276, 7815.17940616235, 7829.882551761714, 7835.177306382833, 7628.466007379486, 7790.493617914832, 7854.60726963651, 7860.292573668368, 7860.489068210562, 2289.370423133639, 2304.2396009316967, 2324.4769926766426, 2324.895379707909, 2327.4065113396146, 2285.925614960974, 2327.8137748980125, 2331.5336932613545, 2332.47519308156, 2334.2997100869757, 2317.432229103872, 2329.895154718033, 2342.1568235435316, 2346.3782097744024, 2375.192434572245, 2292.8624282542933, 2299.448132448217, 2320.0719712115206, 2327.3832434404894, 2327.7904988551113, 2260.2541161416857, 2285.5885940530866, 2285.725712914461, 2285.794278514925, 2287.0737351372723, 7763.301302882767, 7858.960705196495, 7869.370450363957, 7871.134175240719, 7873.448858579902, 4698.483166851644, 4729.148753224453, 4731.905361892777, 4760.119377915063, 4766.285057241407, 3081.383723255358, 3093.0, 3150.7951983121025, 3159.3207460396125, 3178.2372230664705, 1044.2690116918188, 1055.2349546578669, 1067.3809190669392, 1081.6965556504392, 1094.7755710079414, 10553.208509361828, 10563.47182640865, 10601.098906592948, 10638.042576168105, 10640.042396184303, 4124.401961715595, 4178.39413285072, 4182.853600124042, 4255.914881702349, 4298.312270036841, 9114.635414583343, 9116.49859257734, 9130.95434522823, 9133.360664753403, 9164.95417522908, 4627.490975992638, 4639.976800115978, 4678.95321046792, 4699.624030077585, 4713.929291060636, 3759.285735710206, 3781.773093614392, 4228.851990180329, 4318.417013703172, 4326.372675962031, 3778.263238668433, 3787.5833658297565, 3812.561555421162, 3838.1939792643857, 3842.4044273137706, 1162.2851946053286, 1169.7368092179192, 1177.4760231696812, 1184.2124986883798, 1203.2599951030054, 1329.1493444195723, 1333.9599812005656, 1343.4156142078032, 1347.9932600336936, 1348.8516263211038, 7384.815379615445, 7501.812454688567, 7713.730019449293, 7724.0731112266885, 7739.845203096019, 1097.0894157848966, 1143.937083460401, 1194.1103877611235, 1205.270811159236, 1205.52984336109, 6019.879602408015, 6058.636481811105, 6066.726997285133, 6084.787032453843, 6088.543359248074, 9113.0, 9428.0, 9500.049995000445, 9524.666636667684, 9534.189593884597, 9343.672971445967, 9377.624895004123, 9441.339106262496, 9503.382280151767, 9510.334276600572, 7079.327463890922, 7343.1555371133, 7346.7061317546695, 7359.59522226272, 7362.153352364439, 7133.643317833984, 7215.494915356085, 7230.023946767329, 7245.311695388929, 7253.492255542062, 8195.344372450309, 8245.422820402515, 8327.95836020816, 8376.664933402595, 8401.873971890549, 8411.45325553837, 8618.61216245283, 8627.0, 8630.180132887366, 8630.56847157627, 6275.560710750204, 6394.0, 6609.4712423007, 6609.504287178384, 6663.833404164935, 7579.052618422697, 7584.962075189589, 7598.772036838904, 7620.428467864822, 7622.123455802654, 7031.964840175767, 7200.243974382614, 7203.603801790951, 7250.3112204340505, 7304.086989126359, 6894.172699276119, 7022.578645281299, 7074.080369551925, 7146.285371462812, 7168.928310716826, 6996.685149168198, 7104.857902842017, 7132.0, 7142.142942846892, 7150.964245178949, 6646.268910419753, 6663.267040625624, 6665.566738162004, 6684.298148694512, 6685.598864068172, 6672.232693240146, 6681.899771503528, 6729.865402691821, 6785.050092986887, 6786.253512113763], "unit": "ms", "name": "mootools.html", "value": 4570.384351913943}, {"lowerIsBetter": false, "replicates": [347.56380742168574, 349.36241359518885, 352.4149911147494, 353.6039635608116, 359.0932150282001, 6103.847403814902, 6164.075388691698, 6176.567640265183, 6198.969005154973, 6207.0, 5798.304203495586, 5907.970460147704, 5968.7314070866805, 6063.30272018718, 6076.3316035236085, 4639.048994956026, 4656.906861862761, 4660.6970546914345, 4673.813047478096, 4695.3661255730385, 4488.932666010012, 4671.27595222741, 4691.366665500165, 4692.2257827458425, 4700.341952126705, 4521.186186486431, 4571.771411429432, 4679.508651591585, 4690.624750019991, 4699.7415142167165, 4680.251159814414, 4684.625229981593, 4692.53074692528, 4699.224627936386, 4705.1530724469585, 4112.958870411318, 4113.691473139526, 4114.300568903293, 4114.7119701620895, 4124.752514849119, 5715.142728590703, 5779.971100144515, 5786.07422812348, 5795.797147099874, 5801.129830525413, 5316.4683531646915, 5347.0, 5349.14413693811, 5353.357597088336, 5354.625176237665, 6443.420092191725, 6445.258795238514, 6446.452051575622, 6449.290578036413, 6474.805755827286, 4432.49026361966, 4432.977835110803, 4433.578810013044, 4434.977825110886, 4443.133588950156, 6586.571872828251, 6646.23568289648, 6720.6639668016405, 6722.93277067228, 6727.966360168168, 4564.155631208171, 4566.74882881438, 4569.0, 4574.08518296342, 4576.382188404589, 4608.516105808909, 4628.0, 4635.397398338195, 4637.07258548285, 4651.279051746917, 5375.408705042442, 5379.112446446293, 5382.273393091882, 5383.327084114486, 5390.703511306916, 6380.170577824853, 6511.218653761579, 6529.640869752209, 6531.934680653228, 6535.3464653534265, 1614.6447781488055, 1637.582416483789, 1641.1630068665067, 1644.925978330978, 1646.514278287908, 1082.967510974672, 1090.3839330778085, 1090.6727981605486, 1101.867775866885, 1113.9275947063577, 6302.401271879165, 6339.746410143634, 6340.873182536416, 6342.778002769881, 6346.714397852108, 6459.903101453482, 6724.4284235840505, 6728.596284222962, 6729.25978142404, 6731.057651928734, 6166.845828854314, 6239.313675495692, 6326.873462530815, 6336.334684858116, 6377.8724425512155, 3627.365211088049, 3632.9818350908076, 3633.3823250047553, 3662.7985460799378, 3672.9632703673155, 6836.487263455161, 6969.686364113627, 6975.82560435983, 6986.790396288119, 6995.160580730243, 6945.0971373721095, 6958.617276049866, 6958.860822783516, 6966.0, 6971.721131154697, 6998.265182155902, 7010.509264351548, 7012.018317435563, 7015.684294206773, 7016.98253753203, 6671.132752742113, 6739.123913891162, 6780.32196780318, 6797.25230224665, 6805.285445028201, 6676.065350850788, 6686.264510903699, 6688.899666504909, 6696.4977626679165, 6699.062131301719, 6984.3364880336285, 6992.895106573304, 6993.510454268152, 6999.965000174967, 7001.124859392576, 4506.887327816831, 4586.5872071512385, 4592.540745925381, 4593.747343895984, 4605.654575906753, 6777.0, 6791.185057793096, 6800.251972283144, 6800.319968003358, 6804.319568043156, 6585.670716464062, 6588.868222635425, 6597.538172327891, 6599.835004124743, 6603.240627327918, 6363.840903977438, 6495.253045899782, 6549.574277671936, 6564.146660934048, 6620.3710647488415, 6473.255575608677, 6513.250976137805, 6519.8044058678315, 6526.477881769542, 6527.608343499405, 6640.070390145287, 6649.734010639714, 6654.900176497454, 6657.600543967377, 6665.100211471389, 6188.845278868064, 6374.90437643445, 6386.265579458236, 6399.776007839703, 6458.806235812933], "unit": "ms", "name": "prototype.html", "value": 4910.232930683273}, {"lowerIsBetter": false, "replicates": [773.9071311442627, 860.80631857832, 875.4528419737663, 882.5322579033115, 897.7217062710561, 13896.235707036109, 14045.578632641038, 14160.929195354009, 14189.077709948846, 14196.432142714291, 12880.098393112487, 13584.796228056586, 13628.93185534071, 13657.795133073012, 13663.863361366384, 761.0942977856361, 771.7414666086868, 903.2457897655465, 906.4742449379377, 921.5254144115786, 899.4603238057178, 900.7703035725914, 912.4160537256129, 915.6291701860757, 916.1113719691888, 947.8767760191165, 963.8216929867997, 968.9321747477679, 969.0842154164318, 969.7042402067367, 941.5151197133482, 945.2863088368307, 954.1269738189549, 955.3837774635322, 955.4219697083234, 702.3538344722816, 708.9751858684921, 711.5730561663013, 711.5730561663013, 712.6579241963834, 12720.872791272153, 12857.228566286052, 12952.611421657366, 12972.675683107904, 12990.220586764824, 12536.686582835411, 13022.283774392405, 13414.195148291134, 13427.127236729679, 13502.527411540646, 10377.533011014522, 10385.688429347132, 10425.16598672112, 10781.514831832586, 10794.622188223375, 3691.9815400923094, 3773.2830762155104, 3787.034306251888, 3808.447775072599, 3824.1778017726324, 45588.0, 45979.77010114962, 46795.76602116968, 46823.0, 46837.0, 9620.182284505756, 10096.798064038825, 10275.93616778987, 10288.537015834305, 10528.0, 18542.53643658892, 18593.7210941836, 18624.255029798656, 18631.347902823338, 18692.813071869106, 7375.373093287023, 7437.479376443597, 7548.169701332849, 7663.080430348394, 7900.209979002054, 4319.092990471973, 4354.259775838115, 4360.454943132108, 4401.6478681705385, 4425.358323043205, 3147.826869522198, 3164.145680666207, 3173.4129186100645, 3175.857086431116, 3178.8092714437207, 541.7887024060619, 557.6932687022122, 559.6418292292935, 574.7873286883796, 580.3905898806321, 639.5299454900644, 665.8634979829123, 687.6424259385092, 713.2332742302046, 745.0909889934271, 8242.216989386, 8366.916330836613, 8438.535880526508, 8552.871706924401, 8643.17889800468, 705.7388766156555, 714.9034880291094, 736.6022347932163, 756.5082696247373, 758.1660173808876, 3985.8206380712936, 3987.2179147365323, 4022.0950286185957, 4073.0631954650003, 4181.351890456984, 55927.72036139793, 56259.0, 56439.0, 56461.15308270379, 64990.35009649843, 48616.27075593869, 49418.25872611914, 49680.75159624179, 49721.502784972414, 49931.50068499269, 46159.53840461619, 46528.767356163, 46567.76716116466, 46631.300530492066, 47361.0, 7899.921000789918, 7962.880556791537, 8029.0, 8031.718889838828, 8432.114627963976, 35198.648013520564, 35916.64083359238, 36316.09209769671, 36587.0, 36983.63016369802, 43732.56267437285, 45257.547424525335, 45561.54438455573, 47079.0, 47351.28973065476, 10666.46667666629, 11168.0, 11257.04315133223, 11293.943530282297, 11360.091192704398, 12579.685507862378, 12763.87236127664, 12830.358482076046, 12844.357782111045, 13141.145825521311, 9781.706548803548, 10119.949400252952, 10421.843672345072, 10509.421981790769, 10661.733456663334, 10489.737756555842, 10630.8405373921, 10641.89358106409, 10948.726281843017, 11288.040516556184, 8736.61712710193, 8912.688055918012, 10412.375257484575, 10898.673039808818, 11291.209615326849, 9797.755056123653, 9970.651027214013, 10251.128654064489, 10279.897201027894, 10609.045185932995, 8157.34741220689, 8225.177482251727, 8549.401541892257, 8781.736547903573, 9015.639374424949], "unit": "ms", "name": "yui.html", "value": 6432.064628775875}], "name": "dromaeo_css", "value": 7347.560414445334}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 111.0, 105.0, 109.0, 110.0, 110.0, 99.0, 110.0, 110.0, 109.0], "unit": "ms", "name": "ai-astar", "value": 108.2}, {"lowerIsBetter": true, "replicates": [144.0, 122.0, 144.0, 160.0, 125.0, 151.0, 148.0, 121.0, 158.0, 125.0], "unit": "ms", "name": "audio-beat-detection", "value": 139.8}, {"lowerIsBetter": true, "replicates": [160.0, 160.0, 159.0, 160.0, 160.0, 161.0, 159.0, 162.0, 160.0, 159.0], "unit": "ms", "name": "audio-dft", "value": 160.0}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 71.0, 149.0, 70.0, 74.0, 72.0, 72.0, 149.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 87.1}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 144.0, 92.0, 93.0, 93.0, 136.0, 92.0, 94.0, 138.0], "unit": "ms", "name": "audio-oscillator", "value": 106.8}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 146.0, 146.0, 144.0, 145.0, 145.0, 145.0, 145.0, 144.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.0}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 96.0, 95.0, 96.0, 97.0, 95.0, 95.0, 95.0, 94.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [55.0, 55.0, 56.0, 56.0, 55.0, 55.0, 56.0, 54.0, 53.0, 55.0], "unit": "ms", "name": "json-parse-financial", "value": 55.0}, {"lowerIsBetter": true, "replicates": [63.0, 63.0, 64.0, 64.0, 64.0, 63.0, 64.0, 64.0, 64.0, 64.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 63.7}, {"lowerIsBetter": true, "replicates": [77.0, 76.0, 78.0, 77.0, 77.0, 77.0, 78.0, 77.0, 78.0, 77.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 77.2}, {"lowerIsBetter": true, "replicates": [114.0, 124.0, 115.0, 119.0, 118.0, 114.0, 117.0, 118.0, 127.0, 116.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 118.2}, {"lowerIsBetter": true, "replicates": [135.0, 147.0, 141.0, 139.0, 148.0, 144.0, 142.0, 142.0, 142.0, 132.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 141.2}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 63.0, 64.0, 64.0, 62.0, 64.0, 65.0, 64.0, 65.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 64.0}], "name": "kraken", "value": 1470.8000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.25204883759827], "unit": "score", "name": "Richards", "value": 211.07065799999992}, {"lowerIsBetter": false, "replicates": [166.6944490748458], "unit": "score", "name": "DeltaBlue", "value": 396.64188200000007}, {"lowerIsBetter": false, "replicates": [280.662363177098], "unit": "score", "name": "Encrypt", "value": 948.4029029999999}, {"lowerIsBetter": false, "replicates": [5164.948453608247], "unit": "score", "name": "Decrypt", "value": 51.53604191616765}, {"lowerIsBetter": false, "replicates": [960.6147934678194], "unit": "score", "name": "RayTrace", "value": 770.3285489999998}, {"lowerIsBetter": false, "replicates": [544.069640914037], "unit": "score", "name": "Earley", "value": 1224.9589940000005}, {"lowerIsBetter": false, "replicates": [10648.936170212766], "unit": "score", "name": "Boyer", "value": 62.5849370629371}, {"lowerIsBetter": false, "replicates": [23880.95238095238], "unit": "score", "name": "RegExp", "value": 38.146929212362885}, {"lowerIsBetter": false, "replicates": [524.9739854318418], "unit": "score", "name": "Splay", "value": 155.22864420218036}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 23229.282295515553}]} 04:39:48 INFO - RETURN: dromaeo_css: 7347.56 04:39:48 INFO - RETURN: kraken: 1470.80 04:39:48 INFO - RETURN: v8_7: 23229.28 04:39:48 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,53,35]]", "result": "23229.28"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,53,35]]", "result": "1470.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,53,35]]", "result": "7347.56"}}} 04:39:48 INFO - Return code: 0 04:39:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 04:39:49 INFO - # TBPL SUCCESS # 04:39:49 INFO - Running post-action listener: _resource_record_post_action 04:39:49 INFO - Running post-run listener: _resource_record_post_run 04:39:50 INFO - Total resource usage - Wall time: 1220s; CPU: 13.0%; Read bytes: 0; Write bytes: 508616704; Read time: 0; Write time: 380952 04:39:50 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 155820032; Read time: 0; Write time: 169180 04:39:50 INFO - run-tests - Wall time: 1206s; CPU: 13.0%; Read bytes: 0; Write bytes: 266915840; Read time: 0; Write time: 147416 04:39:50 INFO - Running post-run listener: _upload_blobber_files 04:39:50 INFO - Blob upload gear active. 04:39:50 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 04:39:50 INFO - Copying logs to upload dir... 04:39:50 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1260.371100 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-02-01 04:39:48.059273) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-02-01 04:39:48.062768) ========= 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=0333a256a5e4f052382dd180000001b1-1454328623.636062-2120760326 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454320827/firefox-45.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009926 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454320827/firefox-45.0.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.05 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2016-02-01 04:39:48.119420) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-01 04:39:48.120288) ========= 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=0333a256a5e4f052382dd180000001b1-1454328623.636062-2120760326 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004480 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-01 04:39:48.173833) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-01 04:39:48.174540) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-01 04:39:48.175124) ========= ========= Total master_lag: 0.29 =========