builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-005 starttime: 1455227141.61 results: success (0) buildid: 20160211110834 builduid: c20c56813c5e4dcda82cb4971407d78d revision: 07434c70518d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-11 13:45:41.608324) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-11 13:45:41.608815) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-11 13:45:41.609110) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1455227141.317725-2090178529 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006260 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-11 13:45:41.631588) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-11 13:45:41.631908) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-11 13:45:41.645211) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 13:45:41.645583) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1455227141.317725-2090178529 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004553 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 13:45:41.694692) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-11 13:45:41.695005) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-11 13:45:41.695361) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 13:45:41.695631) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1455227141.317725-2090178529 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-11 13:45:42-- 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% 28.3M=0s 2016-02-11 13:45:42 (28.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.146077 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 13:45:41.853948) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 13:45:41.854274) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1455227141.317725-2090178529 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022586 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 13:45:41.903598) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-11 13:45:41.903958) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 07434c70518d --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 07434c70518d --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=7fc86f70bae03e018da0b1d8000001c4-1455227141.317725-2090178529 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-11 13:45:42,384 Setting DEBUG logging. 2016-02-11 13:45:42,384 attempt 1/10 2016-02-11 13:45:42,384 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/07434c70518d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-11 13:45:43,375 unpacking tar archive at: mozilla-beta-07434c70518d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.285430 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-11 13:45:43.201975) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-11 13:45:43.202371) ========= echo 07434c70518d in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'07434c70518d'] 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=7fc86f70bae03e018da0b1d8000001c4-1455227141.317725-2090178529 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07434c70518d program finished with exit code 0 elapsedTime=0.003724 script_repo_revision: '07434c70518d' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-11 13:45:43.250826) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-11 13:45:43.251179) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-11 13:45:43.261866) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-02-11 13:45:43.262256) ========= /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=7fc86f70bae03e018da0b1d8000001c4-1455227141.317725-2090178529 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:45:43 INFO - MultiFileLogger online at 20160211 13:45:43 in /builds/slave/test-pgo 13:45:43 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 13:45:43 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 13:45:43 INFO - {'append_to_log': False, 13:45:43 INFO - 'base_work_dir': '/builds/slave/test-pgo', 13:45:43 INFO - 'blob_upload_branch': 'Mozilla-Beta', 13:45:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 13:45:43 INFO - 'branch': 'Mozilla-Beta', 13:45:43 INFO - 'buildbot_json_path': 'buildprops.json', 13:45:43 INFO - 'config_files': ('talos/linux_config.py',), 13:45:43 INFO - 'default_actions': ('clobber', 13:45:43 INFO - 'read-buildbot-config', 13:45:43 INFO - 'download-and-extract', 13:45:43 INFO - 'populate-webroot', 13:45:43 INFO - 'create-virtualenv', 13:45:43 INFO - 'install', 13:45:43 INFO - 'run-tests'), 13:45:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:45:43 INFO - 'download_minidump_stackwalk': True, 13:45:43 INFO - 'download_symbols': 'ondemand', 13:45:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:45:43 INFO - 'tooltool.py': '/tools/tooltool.py', 13:45:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:45:43 INFO - '/tools/misc-python/virtualenv.py')}, 13:45:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:45:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:45:43 INFO - 'installer_path': 'installer.exe', 13:45:43 INFO - 'log_level': 'info', 13:45:43 INFO - 'log_name': 'talos', 13:45:43 INFO - 'log_to_console': True, 13:45:43 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:45:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:45:43 INFO - 'opt_config_files': (), 13:45:43 INFO - 'pip_index': False, 13:45:43 INFO - 'sps_profile': False, 13:45:43 INFO - 'sps_profile_interval': 0, 13:45:43 INFO - 'suite': 'dromaeojs', 13:45:43 INFO - 'system_bits': '32', 13:45:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:45:43 INFO - 'title': 'talos-linux64-ix-005', 13:45:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:45:43 INFO - 'use_talos_json': True, 13:45:43 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 13:45:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:45:43 INFO - 'work_dir': 'build'} 13:45:43 INFO - ##### 13:45:43 INFO - ##### Running clobber step. 13:45:43 INFO - ##### 13:45:43 INFO - Running pre-action listener: _resource_record_pre_action 13:45:43 INFO - Running main action method: clobber 13:45:43 INFO - rmtree: /builds/slave/test-pgo/build 13:45:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 13:45:44 INFO - Running post-action listener: _resource_record_post_action 13:45:44 INFO - ##### 13:45:44 INFO - ##### Running read-buildbot-config step. 13:45:44 INFO - ##### 13:45:44 INFO - Running pre-action listener: _resource_record_pre_action 13:45:44 INFO - Running main action method: read_buildbot_config 13:45:44 INFO - Using buildbot properties: 13:45:44 INFO - { 13:45:44 INFO - "properties": { 13:45:44 INFO - "buildnumber": 105, 13:45:44 INFO - "product": "firefox", 13:45:44 INFO - "script_repo_revision": "production", 13:45:44 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 13:45:44 INFO - "repository": "", 13:45:44 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 13:45:44 INFO - "buildid": "20160211110834", 13:45:44 INFO - "slavename": "talos-linux64-ix-005", 13:45:44 INFO - "pgo_build": "True", 13:45:44 INFO - "basedir": "/builds/slave/test-pgo", 13:45:44 INFO - "project": "", 13:45:44 INFO - "platform": "ubuntu64_hw", 13:45:44 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:45:44 INFO - "slavebuilddir": "test", 13:45:44 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 13:45:44 INFO - "branch": "mozilla-beta", 13:45:44 INFO - "repo_path": "releases/mozilla-beta", 13:45:44 INFO - "stage_platform": "linux64-pgo", 13:45:44 INFO - "builduid": "c20c56813c5e4dcda82cb4971407d78d", 13:45:44 INFO - "revision": "07434c70518d" 13:45:44 INFO - }, 13:45:44 INFO - "sourcestamp": { 13:45:44 INFO - "repository": "", 13:45:44 INFO - "hasPatch": false, 13:45:44 INFO - "project": "", 13:45:44 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 13:45:44 INFO - "changes": [ 13:45:44 INFO - { 13:45:44 INFO - "category": null, 13:45:44 INFO - "files": [ 13:45:44 INFO - { 13:45:44 INFO - "url": null, 13:45:44 INFO - "name": "http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455217714/firefox-45.0.en-US.linux-x86_64.tar.bz2" 13:45:44 INFO - } 13:45:44 INFO - ], 13:45:44 INFO - "repository": "", 13:45:44 INFO - "rev": "07434c70518d", 13:45:44 INFO - "who": "sendchange", 13:45:44 INFO - "when": 1455226980, 13:45:44 INFO - "number": 7596463, 13:45:44 INFO - "comments": "Bug 1243555: Remove unnecessary nsDocShell static_cast in EventListenerManager::HandleEventInternal(). r=smaug, a=sylvestre", 13:45:44 INFO - "project": "", 13:45:44 INFO - "at": "Thu 11 Feb 2016 13:43:00", 13:45:44 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 13:45:44 INFO - "revlink": "", 13:45:44 INFO - "properties": [ 13:45:44 INFO - [ 13:45:44 INFO - "buildid", 13:45:44 INFO - "20160211110834", 13:45:44 INFO - "Change" 13:45:44 INFO - ], 13:45:44 INFO - [ 13:45:44 INFO - "builduid", 13:45:44 INFO - "c20c56813c5e4dcda82cb4971407d78d", 13:45:44 INFO - "Change" 13:45:44 INFO - ], 13:45:44 INFO - [ 13:45:44 INFO - "pgo_build", 13:45:44 INFO - "True", 13:45:44 INFO - "Change" 13:45:44 INFO - ] 13:45:44 INFO - ], 13:45:44 INFO - "revision": "07434c70518d" 13:45:44 INFO - } 13:45:44 INFO - ], 13:45:44 INFO - "revision": "07434c70518d" 13:45:44 INFO - } 13:45:44 INFO - } 13:45:44 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455217714/firefox-45.0.en-US.linux-x86_64.tar.bz2. 13:45:44 INFO - Running post-action listener: _resource_record_post_action 13:45:44 INFO - ##### 13:45:44 INFO - ##### Running download-and-extract step. 13:45:44 INFO - ##### 13:45:44 INFO - Running pre-action listener: _resource_record_pre_action 13:45:44 INFO - Running main action method: download_and_extract 13:45:44 INFO - mkdir: /builds/slave/test-pgo/build/tests 13:45:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:45:44 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455217714/test_packages.json 13:45:44 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455217714/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 13:45:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455217714/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 13:45:44 INFO - Downloaded 1270 bytes. 13:45:44 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 13:45:44 INFO - Using the following test package requirements: 13:45:44 INFO - {u'common': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 13:45:44 INFO - u'cppunittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 13:45:44 INFO - u'firefox-45.0.en-US.linux-x86_64.cppunittest.tests.zip'], 13:45:44 INFO - u'jittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 13:45:44 INFO - u'jsshell-linux-x86_64.zip'], 13:45:44 INFO - u'mochitest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 13:45:44 INFO - u'firefox-45.0.en-US.linux-x86_64.mochitest.tests.zip'], 13:45:44 INFO - u'mozbase': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 13:45:44 INFO - u'reftest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 13:45:44 INFO - u'firefox-45.0.en-US.linux-x86_64.reftest.tests.zip'], 13:45:44 INFO - u'talos': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 13:45:44 INFO - u'firefox-45.0.en-US.linux-x86_64.talos.tests.zip'], 13:45:44 INFO - u'web-platform': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 13:45:44 INFO - u'firefox-45.0.en-US.linux-x86_64.web-platform.tests.zip'], 13:45:44 INFO - u'webapprt': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 13:45:44 INFO - u'xpcshell': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 13:45:44 INFO - u'firefox-45.0.en-US.linux-x86_64.xpcshell.tests.zip']} 13:45:44 INFO - Downloading packages: [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:45:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:45:44 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455217714/firefox-45.0.en-US.linux-x86_64.common.tests.zip 13:45:44 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455217714/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 13:45:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455217714/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 13:45:45 INFO - Downloaded 21582105 bytes. 13:45:45 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 13:45:45 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 13:45:45 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 13:45:46 INFO - Return code: 0 13:45:46 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 13:45:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:45:46 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455217714/firefox-45.0.en-US.linux-x86_64.common.tests.zip 13:45:46 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455217714/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 13:45:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455217714/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 13:45:46 INFO - Downloaded 21582105 bytes. 13:45:46 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 13:45:46 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 13:45:46 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 13:45:47 INFO - Return code: 0 13:45:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:45:47 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455217714/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 13:45:47 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455217714/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 13:45:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455217714/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 13:45:48 INFO - Downloaded 11132038 bytes. 13:45:48 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 13:45:48 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 13:45:48 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 13:45:48 INFO - Return code: 0 13:45:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:45:48 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455217714/firefox-45.0.en-US.linux-x86_64.tar.bz2 13:45:48 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455217714/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 13:45:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455217714/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 13:45:49 INFO - Downloaded 57938710 bytes. 13:45:49 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455217714/firefox-45.0.en-US.linux-x86_64.tar.bz2 13:45:49 INFO - mkdir: /builds/slave/test-pgo/properties 13:45:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 13:45:49 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 13:45:49 INFO - Contents: 13:45:49 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455217714/firefox-45.0.en-US.linux-x86_64.tar.bz2 13:45:49 INFO - Running post-action listener: _resource_record_post_action 13:45:49 INFO - Running post-action listener: set_extra_try_arguments 13:45:49 INFO - ##### 13:45:49 INFO - ##### Running populate-webroot step. 13:45:49 INFO - ##### 13:45:49 INFO - Running pre-action listener: _resource_record_pre_action 13:45:49 INFO - Running main action method: populate_webroot 13:45:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:45:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:45:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:45:49 INFO - '--tppagecycles', 13:45:49 INFO - '7'], 13:45:49 INFO - 'tests': ['tsvgm']}}, 13:45:49 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 13:45:49 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 13:45:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:45:49 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:45:49 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 13:45:49 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:45:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:45:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:45:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:45:49 INFO - 'talos_options': ['--e10s'], 13:45:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:45:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:45:49 INFO - 'tests': ['damp', 'tps']}, 13:45:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:45:49 INFO - 'talos_options': ['--e10s'], 13:45:49 INFO - 'tests': ['damp', 'tps']}, 13:45:49 INFO - 'g3': {'tests': ['dromaeo_dom']}, 13:45:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:45:49 INFO - 'other': {'tests': ['a11yr', 13:45:49 INFO - 'ts_paint', 13:45:49 INFO - 'tpaint', 13:45:49 INFO - 'sessionrestore', 13:45:49 INFO - 'sessionrestore_no_auto_restore']}, 13:45:49 INFO - 'other-e10s': {'talos_options': ['--e10s'], 13:45:49 INFO - 'tests': ['a11yr', 13:45:49 INFO - 'ts_paint', 13:45:49 INFO - 'tpaint', 13:45:49 INFO - 'sessionrestore', 13:45:49 INFO - 'sessionrestore_no_auto_restore']}, 13:45:49 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 13:45:49 INFO - 'tests': ['a11yr', 13:45:49 INFO - 'ts_paint', 13:45:49 INFO - 'tpaint', 13:45:49 INFO - 'sessionrestore', 13:45:49 INFO - 'sessionrestore_no_auto_restore']}, 13:45:49 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 13:45:49 INFO - 'tests': ['a11yr', 13:45:49 INFO - 'ts_paint', 13:45:49 INFO - 'tpaint', 13:45:49 INFO - 'sessionrestore', 13:45:49 INFO - 'sessionrestore_no_auto_restore']}, 13:45:49 INFO - 'other_l64': {'tests': ['a11yr', 13:45:49 INFO - 'ts_paint', 13:45:49 INFO - 'tpaint', 13:45:49 INFO - 'sessionrestore', 13:45:49 INFO - 'sessionrestore_no_auto_restore']}, 13:45:49 INFO - 'other_nol64': {'tests': ['a11yr', 13:45:49 INFO - 'ts_paint', 13:45:49 INFO - 'tpaint', 13:45:49 INFO - 'sessionrestore', 13:45:49 INFO - 'sessionrestore_no_auto_restore']}, 13:45:49 INFO - 'svgr': {'tests': ['tsvgx', 13:45:49 INFO - 'tsvgr_opacity', 13:45:49 INFO - 'tart', 13:45:49 INFO - 'tscrollx', 13:45:49 INFO - 'cart']}, 13:45:49 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 13:45:49 INFO - 'tests': ['tsvgx', 13:45:49 INFO - 'tsvgr_opacity', 13:45:49 INFO - 'tart', 13:45:49 INFO - 'tscrollx', 13:45:49 INFO - 'cart']}, 13:45:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:45:49 INFO - 'tests': ['tp5o']}, 13:45:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:45:49 INFO - 'talos_options': ['--e10s'], 13:45:49 INFO - 'tests': ['tp5o']}, 13:45:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:45:49 INFO - 'talos_options': ['--xperf_path', 13:45:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:45:49 INFO - 'tests': ['tp5n']}, 13:45:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:45:49 INFO - 'talos_options': ['--e10s', 13:45:49 INFO - '--xperf_path', 13:45:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:45:49 INFO - 'tests': ['tp5n']}}, 13:45:49 INFO - 'talos.zip': {'path': '', 13:45:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:45:49 INFO - Running post-action listener: _resource_record_post_action 13:45:49 INFO - ##### 13:45:49 INFO - ##### Running create-virtualenv step. 13:45:49 INFO - ##### 13:45:49 INFO - Running pre-action listener: _resource_record_pre_action 13:45:49 INFO - Running main action method: create_virtualenv 13:45:49 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 13:45:49 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 13:45:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 13:45:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:45:49 INFO - Using real prefix '/usr' 13:45:49 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 13:45:50 INFO - Installing distribute.............................................................................................................................................................................................done. 13:45:52 INFO - Installing pip.................done. 13:45:52 INFO - Return code: 0 13:45:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 13:45:52 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')]} 13:45:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:45:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:52 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')]} 13:45:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:45:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:52 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 0x7f2d05759f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b09600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b98350>, '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 0x1b99250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b996e0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1455227141.317725-2090178529', '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 13:45:52 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 13:45:52 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 13:45:52 INFO - Using env: {'DISPLAY': ':0', 13:45:52 INFO - 'HOME': '/home/cltbld', 13:45:52 INFO - 'LANG': 'en_US.UTF-8', 13:45:52 INFO - 'LANGUAGE': 'en_US:en', 13:45:52 INFO - 'LOGNAME': 'cltbld', 13:45:52 INFO - 'MAIL': '/var/mail/cltbld', 13:45:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:45:52 INFO - 'MOZ_NO_REMOTE': '1', 13:45:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:45:52 INFO - 'NO_EM_RESTART': '1', 13:45:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:45:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:45:52 INFO - 'PWD': '/builds/slave/test-pgo', 13:45:52 INFO - 'SHELL': '/bin/bash', 13:45:52 INFO - 'SHLVL': '1', 13:45:52 INFO - 'TERM': 'linux', 13:45:52 INFO - 'TMOUT': '86400', 13:45:52 INFO - 'USER': 'cltbld', 13:45:52 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1455227141.317725-2090178529', 13:45:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:45:52 INFO - '_': '/tools/buildbot/bin/python'} 13:45:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:45:52 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 13:45:52 INFO - Cleaning up... 13:45:52 INFO - Return code: 0 13:45:52 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 13:45:52 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')]} 13:45:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:45:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:52 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')]} 13:45:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:45:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:52 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 0x7f2d05759f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b09600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b98350>, '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 0x1b99250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b996e0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1455227141.317725-2090178529', '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 13:45:52 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 13:45:52 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 13:45:52 INFO - Using env: {'DISPLAY': ':0', 13:45:52 INFO - 'HOME': '/home/cltbld', 13:45:52 INFO - 'LANG': 'en_US.UTF-8', 13:45:52 INFO - 'LANGUAGE': 'en_US:en', 13:45:52 INFO - 'LOGNAME': 'cltbld', 13:45:52 INFO - 'MAIL': '/var/mail/cltbld', 13:45:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:45:52 INFO - 'MOZ_NO_REMOTE': '1', 13:45:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:45:52 INFO - 'NO_EM_RESTART': '1', 13:45:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:45:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:45:52 INFO - 'PWD': '/builds/slave/test-pgo', 13:45:52 INFO - 'SHELL': '/bin/bash', 13:45:52 INFO - 'SHLVL': '1', 13:45:52 INFO - 'TERM': 'linux', 13:45:52 INFO - 'TMOUT': '86400', 13:45:52 INFO - 'USER': 'cltbld', 13:45:52 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1455227141.317725-2090178529', 13:45:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:45:52 INFO - '_': '/tools/buildbot/bin/python'} 13:45:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:45:52 INFO - Downloading/unpacking psutil>=0.7.1 13:45:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:45:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:45:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:45:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:45:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:45:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:45:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 13:45:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:45:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:45:54 INFO - Installing collected packages: psutil 13:45:54 INFO - Running setup.py install for psutil 13:45:54 INFO - building 'psutil._psutil_linux' extension 13:45:54 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 13:45:54 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 13:45:54 INFO - building 'psutil._psutil_posix' extension 13:45:54 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 13:45:54 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 13:45:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:45:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:45:54 INFO - Successfully installed psutil 13:45:54 INFO - Cleaning up... 13:45:55 INFO - Return code: 0 13:45:55 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 13:45:55 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')]} 13:45:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:45:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:55 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')]} 13:45:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:45:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:55 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 0x7f2d05759f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b09600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b98350>, '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 0x1b99250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b996e0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1455227141.317725-2090178529', '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 13:45:55 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 13:45:55 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 13:45:55 INFO - Using env: {'DISPLAY': ':0', 13:45:55 INFO - 'HOME': '/home/cltbld', 13:45:55 INFO - 'LANG': 'en_US.UTF-8', 13:45:55 INFO - 'LANGUAGE': 'en_US:en', 13:45:55 INFO - 'LOGNAME': 'cltbld', 13:45:55 INFO - 'MAIL': '/var/mail/cltbld', 13:45:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:45:55 INFO - 'MOZ_NO_REMOTE': '1', 13:45:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:45:55 INFO - 'NO_EM_RESTART': '1', 13:45:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:45:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:45:55 INFO - 'PWD': '/builds/slave/test-pgo', 13:45:55 INFO - 'SHELL': '/bin/bash', 13:45:55 INFO - 'SHLVL': '1', 13:45:55 INFO - 'TERM': 'linux', 13:45:55 INFO - 'TMOUT': '86400', 13:45:55 INFO - 'USER': 'cltbld', 13:45:55 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1455227141.317725-2090178529', 13:45:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:45:55 INFO - '_': '/tools/buildbot/bin/python'} 13:45:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:45:55 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:45:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:45:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:45:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:45:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:45:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:45:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:45:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:45:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:45:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:45:57 INFO - Installing collected packages: mozsystemmonitor 13:45:57 INFO - Running setup.py install for mozsystemmonitor 13:45:57 INFO - Successfully installed mozsystemmonitor 13:45:57 INFO - Cleaning up... 13:45:57 INFO - Return code: 0 13:45:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 13:45:57 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')]} 13:45:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:45:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:57 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')]} 13:45:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:45:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:57 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 0x7f2d05759f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b09600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b98350>, '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 0x1b99250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b996e0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1455227141.317725-2090178529', '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 13:45:57 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 13:45:57 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 13:45:57 INFO - Using env: {'DISPLAY': ':0', 13:45:57 INFO - 'HOME': '/home/cltbld', 13:45:57 INFO - 'LANG': 'en_US.UTF-8', 13:45:57 INFO - 'LANGUAGE': 'en_US:en', 13:45:57 INFO - 'LOGNAME': 'cltbld', 13:45:57 INFO - 'MAIL': '/var/mail/cltbld', 13:45:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:45:57 INFO - 'MOZ_NO_REMOTE': '1', 13:45:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:45:57 INFO - 'NO_EM_RESTART': '1', 13:45:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:45:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:45:57 INFO - 'PWD': '/builds/slave/test-pgo', 13:45:57 INFO - 'SHELL': '/bin/bash', 13:45:57 INFO - 'SHLVL': '1', 13:45:57 INFO - 'TERM': 'linux', 13:45:57 INFO - 'TMOUT': '86400', 13:45:57 INFO - 'USER': 'cltbld', 13:45:57 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1455227141.317725-2090178529', 13:45:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:45:57 INFO - '_': '/tools/buildbot/bin/python'} 13:45:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:45:57 INFO - Downloading/unpacking blobuploader==1.2.4 13:45:57 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 13:45:57 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 13:45:57 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 13:45:57 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 13:45:57 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 13:45:57 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 13:45:59 INFO - Downloading blobuploader-1.2.4.tar.gz 13:45:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:45:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:45:59 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 13:45:59 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 13:45:59 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 13:45:59 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 13:45:59 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 13:45:59 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 13:45:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 13:45:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:45:59 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 13:45:59 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 13:45:59 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 13:45:59 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 13:45:59 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 13:45:59 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 13:45:59 INFO - Downloading docopt-0.6.1.tar.gz 13:45:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 13:45:59 INFO - Installing collected packages: blobuploader, requests, docopt 13:45:59 INFO - Running setup.py install for blobuploader 13:45:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:45:59 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 13:45:59 INFO - Running setup.py install for requests 13:46:00 INFO - Running setup.py install for docopt 13:46:00 INFO - Successfully installed blobuploader requests docopt 13:46:00 INFO - Cleaning up... 13:46:00 INFO - Return code: 0 13:46:00 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:46:00 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')]} 13:46:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:46:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:46:00 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')]} 13:46:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:46:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:46:00 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 0x7f2d05759f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b09600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b98350>, '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 0x1b99250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b996e0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1455227141.317725-2090178529', '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 13:46:00 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 13:46:00 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 13:46:00 INFO - Using env: {'DISPLAY': ':0', 13:46:00 INFO - 'HOME': '/home/cltbld', 13:46:00 INFO - 'LANG': 'en_US.UTF-8', 13:46:00 INFO - 'LANGUAGE': 'en_US:en', 13:46:00 INFO - 'LOGNAME': 'cltbld', 13:46:00 INFO - 'MAIL': '/var/mail/cltbld', 13:46:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:46:00 INFO - 'MOZ_NO_REMOTE': '1', 13:46:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:46:00 INFO - 'NO_EM_RESTART': '1', 13:46:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:46:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:46:00 INFO - 'PWD': '/builds/slave/test-pgo', 13:46:00 INFO - 'SHELL': '/bin/bash', 13:46:00 INFO - 'SHLVL': '1', 13:46:00 INFO - 'TERM': 'linux', 13:46:00 INFO - 'TMOUT': '86400', 13:46:00 INFO - 'USER': 'cltbld', 13:46:00 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1455227141.317725-2090178529', 13:46:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:46:00 INFO - '_': '/tools/buildbot/bin/python'} 13:46:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:46:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:46:00 INFO - Running setup.py (path:/tmp/pip-hJOPxG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:46:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:46:00 INFO - Running setup.py (path:/tmp/pip-ffW5vv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:46:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:46:00 INFO - Running setup.py (path:/tmp/pip-wQmkel-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:46:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:46:00 INFO - Running setup.py (path:/tmp/pip-u4JA3K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:46:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 13:46:00 INFO - Running setup.py (path:/tmp/pip-UiMCFZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 13:46:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:46:01 INFO - Running setup.py (path:/tmp/pip-uWDept-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:46:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:46:01 INFO - Running setup.py (path:/tmp/pip-a5KelB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:46:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:46:01 INFO - Running setup.py (path:/tmp/pip-2fZ5K5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:46:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 13:46:01 INFO - Running setup.py (path:/tmp/pip-QXg2bO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 13:46:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 13:46:01 INFO - Running setup.py (path:/tmp/pip-pAafqV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 13:46:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:46:01 INFO - Running setup.py (path:/tmp/pip-HcNKrr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:46:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:46:01 INFO - Running setup.py (path:/tmp/pip-Antd3L-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:46:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:46:01 INFO - Running setup.py (path:/tmp/pip-yg0OSV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:46:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:46:01 INFO - Running setup.py (path:/tmp/pip-kaRei9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:46:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:46:01 INFO - Running setup.py (path:/tmp/pip-XshZRH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:46:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 13:46:01 INFO - Running setup.py (path:/tmp/pip-mRTml5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 13:46:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 13:46:01 INFO - Running setup.py (path:/tmp/pip-iYPdqr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 13:46:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:46:01 INFO - Running setup.py install for manifestparser 13:46:02 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 13:46:02 INFO - Running setup.py install for mozcrash 13:46:02 INFO - Running setup.py install for mozdebug 13:46:02 INFO - Running setup.py install for mozdevice 13:46:02 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 13:46:02 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 13:46:02 INFO - Running setup.py install for mozfile 13:46:02 INFO - Running setup.py install for mozhttpd 13:46:02 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 13:46:02 INFO - Running setup.py install for mozinfo 13:46:02 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 13:46:02 INFO - Running setup.py install for mozInstall 13:46:02 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 13:46:02 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 13:46:02 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 13:46:02 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 13:46:02 INFO - Running setup.py install for mozleak 13:46:02 INFO - Running setup.py install for mozlog 13:46:02 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 13:46:02 INFO - Running setup.py install for moznetwork 13:46:03 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 13:46:03 INFO - Running setup.py install for mozprocess 13:46:03 INFO - Running setup.py install for mozprofile 13:46:03 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 13:46:03 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 13:46:03 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 13:46:03 INFO - Running setup.py install for mozrunner 13:46:03 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 13:46:03 INFO - Running setup.py install for mozscreenshot 13:46:03 INFO - Running setup.py install for moztest 13:46:03 INFO - Running setup.py install for mozversion 13:46:03 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 13:46:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:46:03 INFO - Cleaning up... 13:46:03 INFO - Return code: 0 13:46:03 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:46:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:46:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:46:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:46:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:46:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:46:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:46:03 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 0x7f2d05759f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b09600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b98350>, '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 0x1b99250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b996e0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1455227141.317725-2090178529', '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 13:46:03 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 13:46:03 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 13:46:03 INFO - Using env: {'DISPLAY': ':0', 13:46:03 INFO - 'HOME': '/home/cltbld', 13:46:03 INFO - 'LANG': 'en_US.UTF-8', 13:46:03 INFO - 'LANGUAGE': 'en_US:en', 13:46:03 INFO - 'LOGNAME': 'cltbld', 13:46:03 INFO - 'MAIL': '/var/mail/cltbld', 13:46:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:46:03 INFO - 'MOZ_NO_REMOTE': '1', 13:46:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:46:03 INFO - 'NO_EM_RESTART': '1', 13:46:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:46:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:46:03 INFO - 'PWD': '/builds/slave/test-pgo', 13:46:03 INFO - 'SHELL': '/bin/bash', 13:46:03 INFO - 'SHLVL': '1', 13:46:03 INFO - 'TERM': 'linux', 13:46:03 INFO - 'TMOUT': '86400', 13:46:03 INFO - 'USER': 'cltbld', 13:46:03 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1455227141.317725-2090178529', 13:46:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:46:03 INFO - '_': '/tools/buildbot/bin/python'} 13:46:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:46:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:46:03 INFO - Running setup.py (path:/tmp/pip-dhD86m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:46:03 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)) 13:46:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:46:03 INFO - Running setup.py (path:/tmp/pip-uBWTYp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:46:04 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)) 13:46:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:46:04 INFO - Running setup.py (path:/tmp/pip-EEQ6wE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:46:04 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)) 13:46:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:46:04 INFO - Running setup.py (path:/tmp/pip-m2ncRz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:46:04 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)) 13:46:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 13:46:04 INFO - Running setup.py (path:/tmp/pip-5IQoWW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 13:46:04 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)) 13:46:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:46:04 INFO - Running setup.py (path:/tmp/pip-rIIdEc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:46:04 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)) 13:46:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:46:04 INFO - Running setup.py (path:/tmp/pip-O3hezZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:46:04 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)) 13:46:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:46:04 INFO - Running setup.py (path:/tmp/pip-rKQfou-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:46:04 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)) 13:46:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 13:46:04 INFO - Running setup.py (path:/tmp/pip-RsaHRX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 13:46:04 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)) 13:46:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 13:46:04 INFO - Running setup.py (path:/tmp/pip-8InuyN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 13:46:04 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)) 13:46:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:46:04 INFO - Running setup.py (path:/tmp/pip-qmhlfw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:46:04 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)) 13:46:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:46:04 INFO - Running setup.py (path:/tmp/pip-uTySwN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:46:04 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)) 13:46:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:46:04 INFO - Running setup.py (path:/tmp/pip-Zq8mYw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:46:04 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)) 13:46:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:46:04 INFO - Running setup.py (path:/tmp/pip-dAC3Fc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:46:04 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)) 13:46:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:46:04 INFO - Running setup.py (path:/tmp/pip-Zyujpv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:46:05 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)) 13:46:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 13:46:05 INFO - Running setup.py (path:/tmp/pip-mifZYA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 13:46:05 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)) 13:46:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 13:46:05 INFO - Running setup.py (path:/tmp/pip-vk4WnL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 13:46:05 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)) 13:46:05 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)) 13:46:05 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)) 13:46:05 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)) 13:46:05 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)) 13:46:05 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)) 13:46:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 13:46:05 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 13:46:05 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 13:46:05 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 13:46:05 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 13:46:05 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 13:46:05 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 13:46:06 INFO - Downloading blessings-1.6.tar.gz 13:46:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 13:46:07 INFO - Installing collected packages: blessings 13:46:07 INFO - Running setup.py install for blessings 13:46:07 INFO - Successfully installed blessings 13:46:07 INFO - Cleaning up... 13:46:07 INFO - Return code: 0 13:46:07 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 13:46:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 13:46:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 13:46:07 INFO - Reading from file tmpfile_stdout 13:46:07 INFO - Current package versions: 13:46:07 INFO - argparse == 1.2.1 13:46:07 INFO - blessings == 1.6 13:46:07 INFO - blobuploader == 1.2.4 13:46:07 INFO - docopt == 0.6.1 13:46:07 INFO - manifestparser == 1.1 13:46:07 INFO - mozInstall == 1.12 13:46:07 INFO - mozcrash == 0.16 13:46:07 INFO - mozdebug == 0.1 13:46:07 INFO - mozdevice == 0.47 13:46:07 INFO - mozfile == 1.2 13:46:07 INFO - mozhttpd == 0.7 13:46:07 INFO - mozinfo == 0.9 13:46:07 INFO - mozleak == 0.1 13:46:07 INFO - mozlog == 3.1 13:46:07 INFO - moznetwork == 0.27 13:46:07 INFO - mozprocess == 0.22 13:46:07 INFO - mozprofile == 0.27 13:46:07 INFO - mozrunner == 6.11 13:46:07 INFO - mozscreenshot == 0.1 13:46:07 INFO - mozsystemmonitor == 0.0 13:46:07 INFO - moztest == 0.7 13:46:07 INFO - mozversion == 1.4 13:46:07 INFO - psutil == 3.1.1 13:46:07 INFO - requests == 1.2.3 13:46:07 INFO - wsgiref == 0.1.2 13:46:07 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:46: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')]} 13:46:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:46:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:46: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')]} 13:46:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:46:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:46:07 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 0x7f2d05759f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b09600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b98350>, '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 0x1b99250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b996e0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1455227141.317725-2090178529', '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 13:46:07 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 13:46:07 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 13:46:07 INFO - Using env: {'DISPLAY': ':0', 13:46:07 INFO - 'HOME': '/home/cltbld', 13:46:07 INFO - 'LANG': 'en_US.UTF-8', 13:46:07 INFO - 'LANGUAGE': 'en_US:en', 13:46:07 INFO - 'LOGNAME': 'cltbld', 13:46:07 INFO - 'MAIL': '/var/mail/cltbld', 13:46:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:46:07 INFO - 'MOZ_NO_REMOTE': '1', 13:46:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:46:07 INFO - 'NO_EM_RESTART': '1', 13:46:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:46:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:46:07 INFO - 'PWD': '/builds/slave/test-pgo', 13:46:07 INFO - 'SHELL': '/bin/bash', 13:46:07 INFO - 'SHLVL': '1', 13:46:07 INFO - 'TERM': 'linux', 13:46:07 INFO - 'TMOUT': '86400', 13:46:07 INFO - 'USER': 'cltbld', 13:46:07 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1455227141.317725-2090178529', 13:46:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:46:07 INFO - '_': '/tools/buildbot/bin/python'} 13:46:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:46:07 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)) 13:46:07 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)) 13:46:07 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)) 13:46:07 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)) 13:46:07 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)) 13:46:07 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)) 13:46:07 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)) 13:46:07 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)) 13:46:07 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)) 13:46:07 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)) 13:46:07 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)) 13:46:07 INFO - Cleaning up... 13:46:07 INFO - Return code: 0 13:46:07 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 13:46: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')]} 13:46:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:46:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:46: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')]} 13:46:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:46:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:46: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2d05759f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b09600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b98350>, '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 0x1b99250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b996e0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1455227141.317725-2090178529', '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 13:46: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', 'jsonschema'] in /builds/slave/test-pgo/build 13:46: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 jsonschema 13:46:07 INFO - Using env: {'DISPLAY': ':0', 13:46:07 INFO - 'HOME': '/home/cltbld', 13:46:07 INFO - 'LANG': 'en_US.UTF-8', 13:46:07 INFO - 'LANGUAGE': 'en_US:en', 13:46:07 INFO - 'LOGNAME': 'cltbld', 13:46:07 INFO - 'MAIL': '/var/mail/cltbld', 13:46:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:46:07 INFO - 'MOZ_NO_REMOTE': '1', 13:46:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:46:07 INFO - 'NO_EM_RESTART': '1', 13:46:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:46:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:46:07 INFO - 'PWD': '/builds/slave/test-pgo', 13:46:07 INFO - 'SHELL': '/bin/bash', 13:46:07 INFO - 'SHLVL': '1', 13:46:07 INFO - 'TERM': 'linux', 13:46:07 INFO - 'TMOUT': '86400', 13:46:07 INFO - 'USER': 'cltbld', 13:46:07 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1455227141.317725-2090178529', 13:46:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:46:07 INFO - '_': '/tools/buildbot/bin/python'} 13:46:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:46:07 INFO - Downloading/unpacking jsonschema 13:46: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 13:46: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 13:46: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 13:46: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 13:46: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 13:46: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 13:46:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:46:09 INFO - Downloading/unpacking functools32 (from jsonschema) 13:46:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:46:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:46:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:46:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:46:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:46:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:46:09 INFO - Downloading functools32-3.2.3-2.tar.gz 13:46:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 13:46:09 INFO - warning: no files found matching '*.txt' 13:46:09 INFO - no previously-included directories found matching 'build' 13:46:09 INFO - no previously-included directories found matching 'dist' 13:46:09 INFO - no previously-included directories found matching '.git*' 13:46:09 INFO - Installing collected packages: jsonschema, functools32 13:46:09 INFO - Running setup.py install for functools32 13:46:10 INFO - warning: no files found matching '*.txt' 13:46:10 INFO - no previously-included directories found matching 'build' 13:46:10 INFO - no previously-included directories found matching 'dist' 13:46:10 INFO - no previously-included directories found matching '.git*' 13:46:10 INFO - Successfully installed jsonschema functools32 13:46:10 INFO - Cleaning up... 13:46:10 INFO - Return code: 0 13:46:10 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 13:46: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')]} 13:46:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:46:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:46: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')]} 13:46:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:46:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:46: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2d05759f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b09600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b98350>, '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 0x1b99250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b996e0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1455227141.317725-2090178529', '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 13:46: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', 'flake8'] in /builds/slave/test-pgo/build 13:46: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 flake8 13:46:10 INFO - Using env: {'DISPLAY': ':0', 13:46:10 INFO - 'HOME': '/home/cltbld', 13:46:10 INFO - 'LANG': 'en_US.UTF-8', 13:46:10 INFO - 'LANGUAGE': 'en_US:en', 13:46:10 INFO - 'LOGNAME': 'cltbld', 13:46:10 INFO - 'MAIL': '/var/mail/cltbld', 13:46:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:46:10 INFO - 'MOZ_NO_REMOTE': '1', 13:46:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:46:10 INFO - 'NO_EM_RESTART': '1', 13:46:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:46:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:46:10 INFO - 'PWD': '/builds/slave/test-pgo', 13:46:10 INFO - 'SHELL': '/bin/bash', 13:46:10 INFO - 'SHLVL': '1', 13:46:10 INFO - 'TERM': 'linux', 13:46:10 INFO - 'TMOUT': '86400', 13:46:10 INFO - 'USER': 'cltbld', 13:46:10 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1455227141.317725-2090178529', 13:46:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:46:10 INFO - '_': '/tools/buildbot/bin/python'} 13:46:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:46:10 INFO - Downloading/unpacking flake8 13:46: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 13:46: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 13:46: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 13:46: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 13:46: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 13:46: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 13:46:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:46:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:46: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 13:46: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 13:46: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 13:46: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 13:46: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 13:46: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 13:46:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:46:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:46: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 13:46: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 13:46: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 13:46: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 13:46: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 13:46: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 13:46:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:46: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 13:46: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 13:46: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 13:46: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 13:46: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 13:46: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 13:46:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 13:46:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:46:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:46:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:46:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:46:12 INFO - no previously-included directories found matching 'docs/_build' 13:46:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:46:12 INFO - Running setup.py install for pep8 13:46:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:46:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:46:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:46:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:46:12 INFO - no previously-included directories found matching 'docs/_build' 13:46:12 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 13:46:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:46:12 INFO - Cleaning up... 13:46:13 INFO - Return code: 0 13:46:13 INFO - Running post-action listener: _resource_record_post_action 13:46:13 INFO - Running post-action listener: _start_resource_monitoring 13:46:13 INFO - Starting resource monitoring. 13:46:13 INFO - ##### 13:46:13 INFO - ##### Running install step. 13:46:13 INFO - ##### 13:46:13 INFO - Running pre-action listener: _resource_record_pre_action 13:46:13 INFO - Running main action method: install 13:46:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 13:46:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 13:46:13 INFO - Reading from file tmpfile_stdout 13:46:13 INFO - Detecting whether we're running mozinstall >=1.0... 13:46:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 13:46:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 13:46:13 INFO - Reading from file tmpfile_stdout 13:46:13 INFO - Output received: 13:46:13 INFO - Usage: mozinstall [options] installer 13:46:13 INFO - Options: 13:46:13 INFO - -h, --help show this help message and exit 13:46:13 INFO - -d DEST, --destination=DEST 13:46:13 INFO - Directory to install application into. [default: 13:46:13 INFO - "/builds/slave/test-pgo"] 13:46:13 INFO - --app=APP Application being installed. [default: firefox] 13:46:13 INFO - mkdir: /builds/slave/test-pgo/build/application 13:46:13 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'] 13:46:13 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 13:46:27 INFO - Reading from file tmpfile_stdout 13:46:27 INFO - Output received: 13:46:27 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 13:46:27 INFO - Running post-action listener: _resource_record_post_action 13:46:27 INFO - ##### 13:46:27 INFO - ##### Running run-tests step. 13:46:27 INFO - ##### 13:46:27 INFO - Running pre-action listener: _resource_record_pre_action 13:46:27 INFO - Running main action method: run_tests 13:46:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 13:46:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 13:46:27 INFO - Python 2.7.3 13:46:27 INFO - Return code: 0 13:46:27 INFO - grabbing minidump binary from tooltool 13:46:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:46:27 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 0x1b98350>, '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 0x1b99250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b996e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 13:46:27 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 13:46:27 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 13:46:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:46:27 INFO - Return code: 0 13:46:27 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 13:46:27 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 13:46:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 13:46:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 13:46:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 13:46:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 13:46:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 13:46:29 INFO - Return code: 0 13:46:29 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/1455217714/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 13:46:29 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/1455217714/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-005 --webServer localhost 13:46:29 INFO - Using env: {'DISPLAY': ':0', 13:46:29 INFO - 'HOME': '/home/cltbld', 13:46:29 INFO - 'LANG': 'en_US.UTF-8', 13:46:29 INFO - 'LANGUAGE': 'en_US:en', 13:46:29 INFO - 'LOGNAME': 'cltbld', 13:46:29 INFO - 'MAIL': '/var/mail/cltbld', 13:46:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 13:46:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 13:46:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:46:29 INFO - 'MOZ_NO_REMOTE': '1', 13:46:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 13:46:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:46:29 INFO - 'NO_EM_RESTART': '1', 13:46:29 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:46:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:46:29 INFO - 'PWD': '/builds/slave/test-pgo', 13:46:29 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 13:46:29 INFO - 'SHELL': '/bin/bash', 13:46:29 INFO - 'SHLVL': '1', 13:46:29 INFO - 'TERM': 'linux', 13:46:29 INFO - 'TMOUT': '86400', 13:46:29 INFO - 'USER': 'cltbld', 13:46:29 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1455227141.317725-2090178529', 13:46:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:46:29 INFO - '_': '/tools/buildbot/bin/python'} 13:46:29 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/1455217714/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--webServer', 'localhost'] with output_timeout 3600 13:46:29 INFO - mozversion INFO | application_buildid: 20160211110834 13:46:29 INFO - mozversion INFO | application_changeset: 07434c70518d0a5aeb7cc00504320def9c0f446c 13:46:29 INFO - mozversion INFO | application_display_name: Nightly 13:46:29 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:46:29 INFO - mozversion INFO | application_name: Firefox 13:46:29 INFO - mozversion INFO | application_remotingname: firefox 13:46:29 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-beta 13:46:29 INFO - mozversion INFO | application_vendor: Mozilla 13:46:29 INFO - mozversion INFO | application_version: 45.0 13:46:29 INFO - mozversion INFO | platform_buildid: 20160211110834 13:46:29 INFO - mozversion INFO | platform_changeset: 07434c70518d0a5aeb7cc00504320def9c0f446c 13:46:29 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-beta 13:46:29 INFO - mozversion INFO | platform_version: 45.0 13:46:29 INFO - 2016-02-11 13:46:29,224 DEBUG : using testdate: 1455227189 13:46:29 INFO - 2016-02-11 13:46:29,224 DEBUG : actual date: 1455227189 13:46:29 INFO - 2016-02-11 13:46:29,232 INFO : starting webserver on 'localhost:44189' 13:46:29 INFO - 2016-02-11 13:46:29,233 INFO : Starting test suite talos-linux64-ix-005 13:46:29 INFO - 2016-02-11 13:46:29,233 INFO : Starting test dromaeo_css 13:46:29 INFO - 2016-02-11 13:46:29,233 DEBUG : operating with platform_type : linux_ 13:46:29 INFO - 2016-02-11 13:46:29,234 INFO : Initialising browser for dromaeo_css test... 13:46:29 INFO - 2016-02-11 13:46:29,247 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpIhDZmQ/profile http://localhost:44189/getInfo.html 13:46:33 INFO - 2016-02-11 13:46:33,103 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:46:33 INFO - 2016-02-11 13:46:33,103 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:46:33 INFO - 2016-02-11 13:46:33,103 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 13:46:33 INFO - 2016-02-11 13:46:33,103 DEBUG : BROWSER_OUTPUT: __metrics 13:46:33 INFO - 2016-02-11 13:46:33,246 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] 13:46:34 INFO - 2016-02-11 13:46:34,050 INFO : Browser initialized. 13:46:34 INFO - 2016-02-11 13:46:34,051 INFO : Running cycle 1/1 for dromaeo_css test... 13:46:34 INFO - 2016-02-11 13:46:34,051 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpIhDZmQ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:46:45 INFO - 2016-02-11 13:46:45,684 DEBUG : BROWSER_OUTPUT: RSS: Main: 132145152 13:46:45 INFO - 2016-02-11 13:46:45,685 DEBUG : BROWSER_OUTPUT: 13:47:37 INFO - 2016-02-11 13:47:37,416 DEBUG : BROWSER_OUTPUT: 1455227257411 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] 13:49:44 INFO - 2016-02-11 13:49:44,409 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44189/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44189/tests/dromaeo/cssquery-ext.html) 13:49:45 INFO - 2016-02-11 13:49:45,656 DEBUG : BROWSER_OUTPUT: RSS: Main: 257708032 13:49:45 INFO - 2016-02-11 13:49:45,656 DEBUG : BROWSER_OUTPUT: 13:52:47 INFO - 2016-02-11 13:52:47,820 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44189/tests/dromaeo/cssquery-ext.html (next: http://localhost:44189/tests/dromaeo/cssquery-jquery.html) 13:52:48 INFO - 2016-02-11 13:52:48,390 DEBUG : BROWSER_OUTPUT: RSS: Main: 211468288 13:52:48 INFO - 2016-02-11 13:52:48,390 DEBUG : BROWSER_OUTPUT: 13:55:50 INFO - 2016-02-11 13:55:50,084 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44189/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44189/tests/dromaeo/cssquery-mootools.html) 13:55:50 INFO - 2016-02-11 13:55:50,646 DEBUG : BROWSER_OUTPUT: RSS: Main: 207433728 13:55:50 INFO - 2016-02-11 13:55:50,646 DEBUG : BROWSER_OUTPUT: 13:58:52 INFO - 2016-02-11 13:58:52,317 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44189/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44189/tests/dromaeo/cssquery-prototype.html) 13:58:52 INFO - 2016-02-11 13:58:52,891 DEBUG : BROWSER_OUTPUT: RSS: Main: 197459968 13:58:52 INFO - 2016-02-11 13:58:52,891 DEBUG : BROWSER_OUTPUT: 14:01:55 INFO - 2016-02-11 14:01:55,391 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44189/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44189/tests/dromaeo/cssquery-yui.html) 14:01:55 INFO - 2016-02-11 14:01:55,960 DEBUG : BROWSER_OUTPUT: RSS: Main: 198074368 14:01:55 INFO - 2016-02-11 14:01:55,960 DEBUG : BROWSER_OUTPUT: 14:04:58 INFO - 2016-02-11 14:04:58,224 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44189/tests/dromaeo/cssquery-yui.html (next: http://localhost:44189/tests/dromaeo/cssquery-dojo.html) 14:04:58 INFO - 2016-02-11 14:04:58,475 DEBUG : BROWSER_OUTPUT: RSS: Main: 239853568 14:04:58 INFO - 2016-02-11 14:04:58,475 DEBUG : BROWSER_OUTPUT: 14:04:58 INFO - 2016-02-11 14:04:58,476 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:04:58 INFO - 2016-02-11 14:04:58,476 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:04:58 INFO - 2016-02-11 14:04:58,477 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:04:58 INFO - 2016-02-11 14:04:58,477 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:04:58 INFO - 2016-02-11 14:04:58,478 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3264.869405223791;3318.784279021862;3336.7497437692177;3338.732901367891;3363.512290717845;5319.92020119698;5353.91969120463;5380.461953804617;5383.327084114486;5405.081136206844;5429.185622156679;5460.235567020621;5488.341399032111;5495.6153069285165;5500.862478438041;4866.197077482211;4978.352814134158;5039.294498770175;5072.4673909239555;5100.362454693163;5026.070177017245;5092.796288148488;5095.108356037697;5095.414027386861;5098.566621837148;4960.776765045582;5004.84985450437;5065.037642847866;5066.442691303953;5072.670276432039;5005.499450054966;5028.094942910275;5080.898382032357;5110.207917772751;5118.232265160219;4942.678725882806;5043.470435604246;5058.949410505885;5083.389993200803;5085.974570127126;5237.764300606482;5289.550388217006;5300.0459917214885;5339.439358867341;5389.595780316492;5789.942100578983;5887.205227294303;5890.440408161261;5896.823095307148;5926.940730592682;5899.764009439617;5900.881982360329;5902.468777809975;5904.527637788967;5932.377100404438;5392.379876314235;5491.697956612345;5525.861853453695;5532.861678458031;5541.002619528484;6016.909746353808;6037.54718396122;6050.606710563799;6054.303755068136;6065.848353791191;5810.331811841692;5841.970790146022;5842.2405087338375;5846.678432686158;5848.444397782204;5629.408912064257;5683.54531637468;5784.2769653793275;5861.677607731531;5903.6457812530525;5854.063349864001;5888.499477544371;5891.646501209942;5902.675352855634;5910.586258961831;5868.941310586925;5879.176915231871;5883.382244864313;5884;5884;4369.169857727022;4446.688731788744;4505.098980203972;4510.751908645056;4626.537346265414;4089.815958281825;4119.773412462283;4122.752634841919;4126.91746165075;4132.33882578792;5616.803411880564;5632.211490391349;5632.3804381518;5649.4350564944;5663.716814159276;5640.492355688008;5711.657300561979;5746.712664366849;5795.681237531976;5828.562857785683;5604.523615492729;5606.103023516218;5614.775408983676;5618.97190514053;5621.100623900156;4964.478729733398;5120.948790512047;5133.820316288912;5136.43499215086;5166.948330516647;6043.8186854394435;6079.8480037998515;6178.011518157074;6178.783742569079;6183.690815459299;5954.46409823118;5956.13636022783;5956.493698035715;5958;5964.582479226499;5891.882162356815;6002.489788368038;6133.570650054453;6150.015997440388;6153.507719382528;5671.688057156896;5723.542116630742;5724.914126288026;5738.225339579103;5766.1350797379055;5889.411058894077;5890.793822216202;5933;5936.436038576328;5951.285845698544;5561.5272701820795;5561.833145005657;5646.435356464485;5735.971320143372;5795.246617939641;5750.396208398058;5799.739011744397;5810.564207684356;5825.475707186373;5842.036064049385;5717.942820571908;5723.170140329546;5729.054705973468;5731.541476681772;5744.684042377709;5551.833444996657;5625.746841392229;5646.265985421869;5757.769689212385;5833.941660583339;5638.210650509014;5690.857728556819;5705.172749951317;5712.571557133315;5721.25623668937 14:04:58 INFO - 2016-02-11 14:04:58,478 DEBUG : BROWSER_OUTPUT: |1;ext.html;587.4947545111204;627.0688028278004;646.2471221027503;647.7117682631228;663.9834004149893;33719;34520.65479345206;34534.48198277028;34571.65428345716;34577;35340;43461.7826910865;44203.557964420426;44207.33688994667;44338.113237735226;9337.953310233457;9440.433573985549;9478;9479;9485.33602647815;8179.386546009044;8372.790680232982;9032.051634578373;9068.138526839939;9197.770055748593;11246.156538259622;11541.249818761795;11548.769024619503;11549.53801847925;11554.422278886022;11079.169062320318;11125.610603628835;11193.048590869786;11203.159763017724;11206.495707693173;8390.664373425056;8641.95679021607;10900.12798976088;11207.383593902332;11543.191976561644;43458.13083738339;43734.125317493475;43812.561874381165;43894.561054389684;43911.34132988008;3564.6435356464403;3631.400818864884;3671.6328367163337;3801.6768574671187;4109.856155034589;33414.23220973783;33584.49623255653;34113.82943085294;34530.309393811986;34830;4327.632151267146;4343.630791382705;4370.082282720632;4383.561643835623;4447.955520444786;308503;309275;310109;310405;310490;65412.34587654158;66644.33355666479;66881.6655916727;73527.63236183891;75236.24763752402;67054;67205.66397167982;67497.98753018709;67590.66204668945;67632.66183669149;16961.49115526536;16997.235124419432;17015.829841701423;17034.31862725502;17075.31698732037;13937.372818223204;13965.86034139666;13967.301634918213;13972.650683732785;14123.152610843383;21964.560708785735;22042.33872983813;22296.108155673915;22307.330780076623;22355.10579576831;7386.2613738625705;7652.196519365498;7677;7689.307962283421;7736.381089512825;1053.5785685725618;1099.455769394155;1115.754534002518;1141.9828702569469;1193.2482536002262;29877.850610747242;30289.394212115636;30989.690103099132;31456;31482;1132.5639628742829;1162.2213117211488;1164.4294295795;1179.8820117988132;1213.9210951288137;14116.647083822781;14490.203038832966;14517.637059073397;14605.85394146045;16385.91807040981;268960;269685;269950;273132;273432;56902.14646780302;57609.42390576124;57779;57882.42117578854;57976.4202357971;1343.7446885091802;1364.0860623382357;1364.9249291288875;1402.3479082226813;1429.2996431748368;27793;27973.571581960176;28496.57255141216;30035.69964300329;30044.11976356923;47553.52446475491;47582.28626570535;47596;47814;48010.75994620004;242680;243927;244076;244269;244376;33523.1619209512;33736.83131584425;33782;34031.4895276576;34121.658783412844;46255;46388.30417543807;46406.53593464022;47122.76438617785;47387.52612473831;35671.28657426889;35796.463053054744;37733.4339984895;38479.807600961816;39305.213895721354;38505.229895402495;39070.467439626875;39104.2179156421;39213.21573568456;39689;38286.42570361502;38557.228855423295;38557.807210963765;38559.6144038556;38628.034299142746;33920.15199620029;34582.30835383329;35310;35860.282794344486;35885.461718074774;26519.469610608066;26838.463230734884;27194.320141995817;27220.183394498195;27478.45043099087 14:04:58 INFO - 2016-02-11 14:04:58,479 DEBUG : BROWSER_OUTPUT: |2;jquery.html;362.9655182757639;364.3678218291264;368.0981595092025;370.549782014852;371.40945896025323;14771.261436928164;16018.439354622591;17482.56293592661;19006.334778282762;19781.40655780329;17192.312307507716;17246.31014759411;17472;17636.911815440904;17680.557986050324;5598.104303311471;5719.971400142994;5735.053716136832;5745;5748.597598168109;4332.415123958257;4439.578240067189;5623.044082505984;6138.14066030756;6315.715792789336;6089.238845144357;6204.720787564571;6230.501559875222;6260.4991600672065;6260.812175634738;6276.68616569172;6308.432241098278;6309.558330916838;6311.747530098791;6317.77887773928;5378.757955891994;5466.371367292732;5487.670739755627;5490.231367608538;5492.368377636543;22081.116755329927;22191.889040554855;22239.22162724297;22481.662775058387;22657.09371625133;2270.3075561953597;2329.94175145621;2337.2754446121585;2359.2922123362923;2427.2475532584954;13642.931785341108;13852.722945541134;14167.149971001772;14199.78700319496;14436.422543098264;1896.82928536431;1919.4721451600783;1930.8744931579542;1948.1038722187811;2017.979820201794;64526;66212;66231;66476.66761666161;67754.32245677529;9762.438009918522;9919;10022;10038.447885366375;10113.848292275621;12818.871811281955;12943;12995;13005.609831705064;13019.153755006084;7914.683412663429;8059.355251579859;8063.758087257392;8160.102388737234;8376.49741015541;8083.1916808319875;8127.471714338549;8139.593020349077;8171.387145964077;8208;6104.497683916885;6105.145279660851;6120.846978825565;6128.724207410677;6291.182146321041;1614.2090375715816;1635.2641311409914;1684.1663376628646;1724.5257554172704;1746.5371676505736;955.5938726041404;964.6045121500291;1018.2719355660738;1087.7389426537575;1096.4736926275273;16998.150092495325;17444.215010324566;17606;17753.201105950262;17863.73204401935;1025.707673313117;1046.6179844356907;1068.2682362581656;1080.5137688040413;1107.2636696596835;10152.441615711206;10337.17302615804;10391.064804167661;10408.895911040943;10467.947660261802;477348;630442;632033;639300;658633;79175.60412197902;85202.99999999876;85622;87994;88369.11630883609;1243.6828608704723;1244.0918129765323;1295.6890346317005;1305.9020573457028;1333.466613354666;15564.610884727972;16033.679326413174;16352.67294654124;16410.179491025163;16485.752713709542;33833.66166338305;37435.812820935724;37529.6247037537;37727.81136094302;38976.80511597424;40966;43760.781196095086;45211.773941130086;48695.26957095717;48871;9169.083091690778;9323.254139668947;9404;9479.47862867549;9495.14543691071;17416.73874891903;17763.200655970253;17873.553161170556;17905.731414029062;17977.280908763503;14043.50847720325;14098.859011409755;14653.194074326015;14726.354237974145;15055.473058442902;15187.696246075238;15409.229538523254;15526.689466210839;15756.842431575538;16113.758293625839;15685.686286274438;15896.76154857655;15999.440019599258;16154.192290385668;16303.67392652164;9501.192398645917;9548.236141108833;9561.61753529851;9576.76058098553;9613.182879455324;15304.617384565476;15450.150241736812;15501.379944802082;15544.766828497808;15807.446739364066 14:04:58 INFO - 2016-02-11 14:04:58,481 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1531.5941275561975;1600.0239853689252;1634.6894090122883;1748.7551742756016;1870.0743132149587;7289.599072051035;7490.88763668544;7495.475316727831;7498.700051997927;7502;6811.761588344409;7002.124734408199;7002.369786719194;7005.474589405802;7412.258774122599;2171.771963943791;2195.4401627584944;2215.4904371994453;2217.6119179143666;2219.3009202101366;2317.6639387288833;2332.7200735911715;2386.331827088409;2389.581823180936;2391.1033362489065;1999.3102379678987;2038.042120203502;2253.740819805727;2309;2365.219477572397;2267.455810605459;2274.7384050834116;2276.044061494168;2282.486440550888;2283.646034864582;2221.2891874600136;2222.5999320122373;2228.5877112734033;2241.7421996470453;2243.887805609713;7808.375329973588;7847.6860925562905;7858.921410785876;7902.209779022051;7903.644336004836;4605.8024913522395;4656.32483289921;4657.441107067174;4719.811207551694;4734.739589322586;2979.970200297991;3039.1642298368124;3095.4273459409856;3114.143610507106;3116.9064928052194;1021.8262895307815;1028.0798685176799;1041.0890470838017;1041.671873359889;1071.8017166824163;10551.47242637865;10572.735681607945;10587.470626468723;10587.576496940113;10606.310589811716;4221.176870510221;4230.069384735353;4266.935995960063;4270.252705776476;4283.678724095706;8992.280617550581;9046.547672616343;9078.591463384164;9080;9095.772605684779;4767.594754445911;4767.976160119178;4772.0217355442055;4774.474807771142;4775.594074503706;4367.2575662137515;4380.6057454829215;4382.430284063052;4383.693141480066;4384.364267181241;3682.0426689061037;3725;3753.7184711146774;3753.9624603753614;3759.49246851677;1115.9442027898572;1124.7919134959895;1128.7414532795874;1133.2633788037842;1143.6054561176381;981.6122631560494;987.2940847294219;1016.2378216337746;1036.4247842447364;1160.7272291011604;7322.633868306563;7389.8152546186775;7396.149442814038;7399.038125043709;7400.851982960311;1183.2427246562206;1184.1000839362148;1206.5294535131306;1208.9818652720217;1224.773416917873;5890.676012819336;5931.11033344993;5959.046552551657;5959.314678811992;5960.910586341209;8500.702475413455;8596.914030859736;8598.613062412081;8714.433561818461;8723.214910658071;8584.270337021424;8590.65637374498;8603.09667484905;8604.0965698602;8605.397622166389;7023.719051237893;7090.6100164491445;7303.233160518175;7303.817404564822;7307.963460182665;7431.108267007994;7460.776176714708;7546.962265188639;7558.433117516099;7566.962165189138;8409.95795021021;8471.788205294917;8476.449030812977;8642.524661143447;8658.78353041179;8615;8633.179847914438;8787.033426323227;8805.295576354005;8809.163129502687;6651.534392592472;6695.832604184934;6704.497162712719;6705.396514313735;6706.899396509154;7327.74352897646;7368;7371.8157046074275;7374.446916481178;7378.409727221917;6939.930600694131;7280.817979550554;7295.124585049828;7340.632968351668;7361.079865016873;6242.222111603473;6422.743090276336;6797.0823938767635;6829.317068293131;6939.826504337432;6734;6795.218549866829;6799.558028728117;6800.557963732342;6818.420434263143;6321.936780632135;6335.524835637253;6336.334684858023;6339.809805705836;6431.131797207504;6513.283538810632;6556.901646475211;6556.967215163893;6557.868842623026;6560.44236239925 14:04:58 INFO - 2016-02-11 14:04:58,482 DEBUG : BROWSER_OUTPUT: |4;prototype.html;341.3037403696459;341.4604924219733;342.87999200279904;346.4750902382889;351.5675718865794;5868.794592189274;6048.818535443933;6050.878982420349;6059.606125601833;6107.389261073896;5837.678927658977;6024.9698751506185;6035.879282414349;6049.2136022317145;6055.455009049185;4671;4672.462666793312;4677.602403795681;4685.039566888797;4686.390769199999;4468.6425085993205;4526.524714904937;4587.770611469413;4623.884402889921;4672.229082201433;4590.908181836361;4591.357209990604;4596.655250856199;4616.053708989666;4618.261078227484;4592.6555508337005;4608.009278005245;4611.054733779601;4611.354410382549;4620.214563524209;4037.6971727120585;4047.8785636430953;4061.776602286873;4063.97968010161;4069.938950915709;5689.118186681071;5744.8851022979725;5745.913811292792;5758.136279558058;5771.624844385144;5419.214213938996;5429.425466614677;5431.375391829951;5433.347998240237;5440.319960004999;6183.227096612924;6410.519211059142;6418.967905160491;6425.582337148117;6426.807195784134;4378.64970802335;4413.933790993137;4524.864254072383;4528.139653465831;4533.886652833673;6702.83242918926;6736.730530778763;6739.056532085512;6741.157355330583;6745.93254067453;4622.514635963243;4632.166210082218;4636.165490211794;4638.257878739386;4642.9767851161205;4440.822367105279;4543.409356783597;4607.76961151941;4683.81264749413;4691.5308469152815;5351.491608297206;5355.437679043722;5358.544523715528;5365.946340536622;5366.114591092504;6503.8699226015215;6505.186851643544;6520.076577409675;6526.314736952647;6526.902096468557;1588.1979600301775;1602.5352647732261;1604.3181647799638;1604.6549991751829;1612.5323656139587;986.6990567876867;996.1035068438464;1001.5493028137367;1066.5520481397832;1094.1684319916762;5733.140028995684;6181.567290289727;6246.781362652286;6316.336784637547;6422.6467544285515;6658.766943156967;6803.353681400358;6804.6257455840405;6816.318368163144;6825.931740682529;6388.425041746265;6398.968005160037;6402.679866006681;6404.647744374104;6411.871762564816;3601.819909004539;3659.7621154624862;3661.9450708239397;3664.0839790052487;3664.303782281358;6891;7055.2239253682055;7060.18807837095;7065.1521817382245;7066.293370662893;6955.408790252784;6957.1651401832105;6963.164420269499;6965.547239429421;6966.407855332252;6775.288594697585;7036.472264580177;7038.225795162528;7059.117610298713;7061.329173728487;6464.385883341075;6578.967105164444;6625;6756.256811750605;6759.695813688494;6685.228414470266;6698.765543205965;6713.026611141455;6720.932790672031;6727.360900714424;6993.0908981832035;7000.964995174992;7004;7004.509684322048;7012.088428504262;4448;4503.166914120898;4548.909021819479;4566.748828814447;4572.725636461823;6667.166604174478;6720.294369091175;6723.310675729552;6726.899096513458;6736.66316684154;6538.8365290868105;6552.63960482178;6554.573952693059;6558.114654521579;6567.31043240472;6418.711157997808;6520.706568204537;6527.05357723137;6565.441937435371;6574.638394888327;6455.774047908489;6472.029195620695;6477.967610161919;6484.1894763154605;6484.448821850006;6602.438792702674;6606.471482281502;6616.900746488903;6620.073189753534;6620.139381880324;6305.337939516285;6426.742930282736;6492.220933488012;6498.155239818793;6499.610023398611 14:04:58 INFO - 2016-02-11 14:04:58,482 DEBUG : BROWSER_OUTPUT: |5;yui.html;771.3289438188776;832.7418500264919;856.242225630317;944.5371767833759;972.3485264872537;14606.19665918374;14612.123272603638;14679;14852.183129927864;14866.256687165625;14085.859141408582;14103.435862565486;14154.363053662584;14178.858211417883;14191.290435478237;761.1779278379365;771.7028943856627;771.7183228121723;894.1952242981304;916.9083091690844;922.7001224602031;924.8705181274627;934.009949453578;934.0845970948441;935.046252822121;968.1963969904962;977.4037836919473;977.4086677560081;978.3151793744372;978.5303054533828;795.932345750612;806.1253539909176;945.1965829045325;949.7340744591526;950.4202436513721;705.7812078255757;707.2750430808411;707.2785758526326;709.2269426325279;710.8436144048301;14123;14340.856591434056;14369.425222991067;14377.78433323501;14392.856071439257;12514.3742812859;12736;12904.741905161938;12970.156939798882;13008.154469959518;10951.616693415772;11003.669889903236;11775.352355620438;11882.168248222628;12094.516219351215;3815.923681526354;3839.4816699745734;3854.2869569129803;3888.8833334999995;3927.8821635350987;44413.111737765386;45058.32412513815;45327.77336113331;45513.77243113763;48843.99999999964;9806.803863922823;9895.208383329316;9902.752431189278;9961.103500684972;10066.345687530433;18754.531136721693;18767.530811729815;18783.436496905113;18789.530261743294;18841;8051.2351326623875;8317.459365141367;8350.62422191003;8407.45351552147;8555.486670799772;4529.547045295444;4561.680682352204;4567.703099298535;4702.435707715096;4776.95223047772;3256.739460843127;3266.2977459846247;3282.113829266085;3288.539604455378;3290.276139249361;596.4035964035965;600.6246096189882;616.1158737212115;616.1743264026227;618.6937465954381;613.0099888679839;669.8626781509779;694.3334398977039;699.720111955222;722.5375759513915;8594.054653988056;8651.178138076873;8751.693690720795;8848;8912.331575131891;690.1511141296234;695.3394275438354;696.3663066609463;700.4431476975816;715.3990647855826;4354.695171337976;4409.316555933835;4511.390962220124;4601.562851529099;4823.300621409876;60299.39700602938;60560.697196513735;60982.69508652517;61822.69088654528;63151.6842415785;56869.87215703176;57185.71407143021;57186.7140664294;57931;58687;48874.02251955012;48966.510334896906;49093.75453122783;49348.50651493511;49949.750251249236;9596.95201523988;9718.805623887623;9772.853407198756;9931.950340248253;9939;35599.64400355963;35667.46498802468;35974.820125899205;36722;36736.63263367439;40942.38586421266;41299;42100.789496052326;46119.76940115278;46174.53825461702;12101;12482.812757808822;12662.430190641258;13499.86500134986;13785.931070344985;13295.268760218281;13366.599002029954;13588.25264610456;14259.786103208253;14313.355898984779;12043.578474753342;12206.450709718261;12391.93804030974;12645;12995.28525931083;11986.76026479483;12029.338386388483;12457.875421246034;12543.56097536582;12832.615021549369;11616.361100139573;11774.882251177722;12212.57255996036;12617.81073283883;12812.167209131376;10718.785624287315;10945.343279403261;11015.72460688457;11028.779424411627;11127.276727012719;10689.732756681145;10699.625513107005;10755.408452535186;10863.619773307897;11007.394593297446 14:04:58 INFO - 2016-02-11 14:04:58,482 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:04:58 INFO - 2016-02-11 14:04:58,482 DEBUG : BROWSER_OUTPUT: __start_cc_report 14:04:58 INFO - 2016-02-11 14:04:58,482 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1010 14:04:58 INFO - 2016-02-11 14:04:58,482 DEBUG : BROWSER_OUTPUT: __end_cc_report 14:04:58 INFO - 2016-02-11 14:04:58,482 DEBUG : BROWSER_OUTPUT: __startTimestamp1455228298476__endTimestamp 14:04:58 INFO - 2016-02-11 14:04:58,482 DEBUG : BROWSER_OUTPUT: 14:04:58 INFO - 2016-02-11 14:04:58,483 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:04:58 INFO - 2016-02-11 14:04:58,483 DEBUG : BROWSER_OUTPUT: Number of tests: 6 14:04:58 INFO - 2016-02-11 14:04:58,483 DEBUG : BROWSER_OUTPUT: 14:04:58 INFO - 2016-02-11 14:04:58,483 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5470.02 Median:5649.44 stddev:593.12 (10.5%) stddev-sans-first:569.15 14:04:58 INFO - 2016-02-11 14:04:58,484 DEBUG : BROWSER_OUTPUT: Values: 3264.9 3318.8 3336.7 3338.7 3363.5 5319.9 5353.9 5380.5 5383.3 5405.1 5429.2 5460.2 5488.3 5495.6 5500.9 4866.2 4978.4 5039.3 5072.5 5100.4 5026.1 5092.8 5095.1 5095.4 5098.6 4960.8 5004.8 5065.0 5066.4 5072.7 5005.5 5028.1 5080.9 5110.2 5118.2 4942.7 5043.5 5058.9 5083.4 5086.0 5237.8 5289.6 5300.0 5339.4 5389.6 5789.9 5887.2 5890.4 5896.8 5926.9 5899.8 5900.9 5902.5 5904.5 5932.4 5392.4 5491.7 5525.9 5532.9 5541.0 6016.9 6037.5 6050.6 6054.3 6065.8 5810.3 5842.0 5842.2 5846.7 5848.4 5629.4 5683.5 5784.3 5861.7 5903.6 5854.1 5888.5 5891.6 5902.7 5910.6 5868.9 5879.2 5883.4 5884.0 5884.0 4369.2 4446.7 4505.1 4510.8 4626.5 4089.8 4119.8 4122.8 4126.9 4132.3 5616.8 5632.2 5632.4 5649.4 5663.7 5640.5 5711.7 5746.7 5795.7 5828.6 5604.5 5606.1 5614.8 5619.0 5621.1 4964.5 5120.9 5133.8 5136.4 5166.9 6043.8 6079.8 6178.0 6178.8 6183.7 5954.5 5956.1 5956.5 5958.0 5964.6 5891.9 6002.5 6133.6 6150.0 6153.5 5671.7 5723.5 5724.9 5738.2 5766.1 5889.4 5890.8 5933.0 5936.4 5951.3 5561.5 5561.8 5646.4 5736.0 5795.2 5750.4 5799.7 5810.6 5825.5 5842.0 5717.9 5723.2 5729.1 5731.5 5744.7 5551.8 5625.7 5646.3 5757.8 5833.9 5638.2 5690.9 5705.2 5712.6 5721.3 14:04:58 INFO - 2016-02-11 14:04:58,484 DEBUG : BROWSER_OUTPUT: 14:04:58 INFO - 2016-02-11 14:04:58,484 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:46611.31 Median:34553.07 stddev:71893.12 (208.1%) stddev-sans-first:72011.74 14:04:58 INFO - 2016-02-11 14:04:58,484 DEBUG : BROWSER_OUTPUT: Values: 587.5 627.1 646.2 647.7 664.0 33719.0 34520.7 34534.5 34571.7 34577.0 35340.0 43461.8 44203.6 44207.3 44338.1 9338.0 9440.4 9478.0 9479.0 9485.3 8179.4 8372.8 9032.1 9068.1 9197.8 11246.2 11541.2 11548.8 11549.5 11554.4 11079.2 11125.6 11193.0 11203.2 11206.5 8390.7 8642.0 10900.1 11207.4 11543.2 43458.1 43734.1 43812.6 43894.6 43911.3 3564.6 3631.4 3671.6 3801.7 4109.9 33414.2 33584.5 34113.8 34530.3 34830.0 4327.6 4343.6 4370.1 4383.6 4448.0 308503.0 309275.0 310109.0 310405.0 310490.0 65412.3 66644.3 66881.7 73527.6 75236.2 67054.0 67205.7 67498.0 67590.7 67632.7 16961.5 16997.2 17015.8 17034.3 17075.3 13937.4 13965.9 13967.3 13972.7 14123.2 21964.6 22042.3 22296.1 22307.3 22355.1 7386.3 7652.2 7677.0 7689.3 7736.4 1053.6 1099.5 1115.8 1142.0 1193.2 29877.9 30289.4 30989.7 31456.0 31482.0 1132.6 1162.2 1164.4 1179.9 1213.9 14116.6 14490.2 14517.6 14605.9 16385.9 268960.0 269685.0 269950.0 273132.0 273432.0 56902.1 57609.4 57779.0 57882.4 57976.4 1343.7 1364.1 1364.9 1402.3 1429.3 27793.0 27973.6 28496.6 30035.7 30044.1 47553.5 47582.3 47596.0 47814.0 48010.8 242680.0 243927.0 244076.0 244269.0 244376.0 33523.2 33736.8 33782.0 34031.5 34121.7 46255.0 46388.3 46406.5 47122.8 47387.5 35671.3 35796.5 37733.4 38479.8 39305.2 38505.2 39070.5 39104.2 39213.2 39689.0 38286.4 38557.2 38557.8 38559.6 38628.0 33920.2 34582.3 35310.0 35860.3 35885.5 26519.5 26838.5 27194.3 27220.2 27478.5 14:04:58 INFO - 2016-02-11 14:04:58,484 DEBUG : BROWSER_OUTPUT: 14:04:58 INFO - 2016-02-11 14:04:58,484 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:31651.06 Median:12463.70 stddev:99801.10 (800.7%) stddev-sans-first:100053.42 14:04:58 INFO - 2016-02-11 14:04:58,485 DEBUG : BROWSER_OUTPUT: Values: 363.0 364.4 368.1 370.5 371.4 14771.3 16018.4 17482.6 19006.3 19781.4 17192.3 17246.3 17472.0 17636.9 17680.6 5598.1 5720.0 5735.1 5745.0 5748.6 4332.4 4439.6 5623.0 6138.1 6315.7 6089.2 6204.7 6230.5 6260.5 6260.8 6276.7 6308.4 6309.6 6311.7 6317.8 5378.8 5466.4 5487.7 5490.2 5492.4 22081.1 22191.9 22239.2 22481.7 22657.1 2270.3 2329.9 2337.3 2359.3 2427.2 13642.9 13852.7 14167.1 14199.8 14436.4 1896.8 1919.5 1930.9 1948.1 2018.0 64526.0 66212.0 66231.0 66476.7 67754.3 9762.4 9919.0 10022.0 10038.4 10113.8 12818.9 12943.0 12995.0 13005.6 13019.2 7914.7 8059.4 8063.8 8160.1 8376.5 8083.2 8127.5 8139.6 8171.4 8208.0 6104.5 6105.1 6120.8 6128.7 6291.2 1614.2 1635.3 1684.2 1724.5 1746.5 955.6 964.6 1018.3 1087.7 1096.5 16998.2 17444.2 17606.0 17753.2 17863.7 1025.7 1046.6 1068.3 1080.5 1107.3 10152.4 10337.2 10391.1 10408.9 10467.9 477348.0 630442.0 632033.0 639300.0 658633.0 79175.6 85203.0 85622.0 87994.0 88369.1 1243.7 1244.1 1295.7 1305.9 1333.5 15564.6 16033.7 16352.7 16410.2 16485.8 33833.7 37435.8 37529.6 37727.8 38976.8 40966.0 43760.8 45211.8 48695.3 48871.0 9169.1 9323.3 9404.0 9479.5 9495.1 17416.7 17763.2 17873.6 17905.7 17977.3 14043.5 14098.9 14653.2 14726.4 15055.5 15187.7 15409.2 15526.7 15756.8 16113.8 15685.7 15896.8 15999.4 16154.2 16303.7 9501.2 9548.2 9561.6 9576.8 9613.2 15304.6 15450.2 15501.4 15544.8 15807.4 14:04:58 INFO - 2016-02-11 14:04:58,485 DEBUG : BROWSER_OUTPUT: 14:04:58 INFO - 2016-02-11 14:04:58,485 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5400.27 Median:6335.93 stddev:2748.07 (43.4%) stddev-sans-first:2740.40 14:04:58 INFO - 2016-02-11 14:04:58,486 DEBUG : BROWSER_OUTPUT: Values: 1531.6 1600.0 1634.7 1748.8 1870.1 7289.6 7490.9 7495.5 7498.7 7502.0 6811.8 7002.1 7002.4 7005.5 7412.3 2171.8 2195.4 2215.5 2217.6 2219.3 2317.7 2332.7 2386.3 2389.6 2391.1 1999.3 2038.0 2253.7 2309.0 2365.2 2267.5 2274.7 2276.0 2282.5 2283.6 2221.3 2222.6 2228.6 2241.7 2243.9 7808.4 7847.7 7858.9 7902.2 7903.6 4605.8 4656.3 4657.4 4719.8 4734.7 2980.0 3039.2 3095.4 3114.1 3116.9 1021.8 1028.1 1041.1 1041.7 1071.8 10551.5 10572.7 10587.5 10587.6 10606.3 4221.2 4230.1 4266.9 4270.3 4283.7 8992.3 9046.5 9078.6 9080.0 9095.8 4767.6 4768.0 4772.0 4774.5 4775.6 4367.3 4380.6 4382.4 4383.7 4384.4 3682.0 3725.0 3753.7 3754.0 3759.5 1115.9 1124.8 1128.7 1133.3 1143.6 981.6 987.3 1016.2 1036.4 1160.7 7322.6 7389.8 7396.1 7399.0 7400.9 1183.2 1184.1 1206.5 1209.0 1224.8 5890.7 5931.1 5959.0 5959.3 5960.9 8500.7 8596.9 8598.6 8714.4 8723.2 8584.3 8590.7 8603.1 8604.1 8605.4 7023.7 7090.6 7303.2 7303.8 7308.0 7431.1 7460.8 7547.0 7558.4 7567.0 8410.0 8471.8 8476.4 8642.5 8658.8 8615.0 8633.2 8787.0 8805.3 8809.2 6651.5 6695.8 6704.5 6705.4 6706.9 7327.7 7368.0 7371.8 7374.4 7378.4 6939.9 7280.8 7295.1 7340.6 7361.1 6242.2 6422.7 6797.1 6829.3 6939.8 6734.0 6795.2 6799.6 6800.6 6818.4 6321.9 6335.5 6336.3 6339.8 6431.1 6513.3 6556.9 6557.0 6557.9 6560.4 14:04:58 INFO - 2016-02-11 14:04:58,486 DEBUG : BROWSER_OUTPUT: 14:04:58 INFO - 2016-02-11 14:04:58,486 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5432.80 Median:6215.00 stddev:1664.72 (26.8%) stddev-sans-first:1624.94 14:04:58 INFO - 2016-02-11 14:04:58,487 DEBUG : BROWSER_OUTPUT: Values: 341.3 341.5 342.9 346.5 351.6 5868.8 6048.8 6050.9 6059.6 6107.4 5837.7 6025.0 6035.9 6049.2 6055.5 4671.0 4672.5 4677.6 4685.0 4686.4 4468.6 4526.5 4587.8 4623.9 4672.2 4590.9 4591.4 4596.7 4616.1 4618.3 4592.7 4608.0 4611.1 4611.4 4620.2 4037.7 4047.9 4061.8 4064.0 4069.9 5689.1 5744.9 5745.9 5758.1 5771.6 5419.2 5429.4 5431.4 5433.3 5440.3 6183.2 6410.5 6419.0 6425.6 6426.8 4378.6 4413.9 4524.9 4528.1 4533.9 6702.8 6736.7 6739.1 6741.2 6745.9 4622.5 4632.2 4636.2 4638.3 4643.0 4440.8 4543.4 4607.8 4683.8 4691.5 5351.5 5355.4 5358.5 5365.9 5366.1 6503.9 6505.2 6520.1 6526.3 6526.9 1588.2 1602.5 1604.3 1604.7 1612.5 986.7 996.1 1001.5 1066.6 1094.2 5733.1 6181.6 6246.8 6316.3 6422.6 6658.8 6803.4 6804.6 6816.3 6825.9 6388.4 6399.0 6402.7 6404.6 6411.9 3601.8 3659.8 3661.9 3664.1 3664.3 6891.0 7055.2 7060.2 7065.2 7066.3 6955.4 6957.2 6963.2 6965.5 6966.4 6775.3 7036.5 7038.2 7059.1 7061.3 6464.4 6579.0 6625.0 6756.3 6759.7 6685.2 6698.8 6713.0 6720.9 6727.4 6993.1 7001.0 7004.0 7004.5 7012.1 4448.0 4503.2 4548.9 4566.7 4572.7 6667.2 6720.3 6723.3 6726.9 6736.7 6538.8 6552.6 6554.6 6558.1 6567.3 6418.7 6520.7 6527.1 6565.4 6574.6 6455.8 6472.0 6478.0 6484.2 6484.4 6602.4 6606.5 6616.9 6620.1 6620.1 6305.3 6426.7 6492.2 6498.2 6499.6 14:04:58 INFO - 2016-02-11 14:04:58,487 DEBUG : BROWSER_OUTPUT: 14:04:58 INFO - 2016-02-11 14:04:58,487 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14600.13 Median:45420.77 stddev:16598.51 (36.5%) stddev-sans-first:16612.58 14:04:58 INFO - 2016-02-11 14:04:58,487 DEBUG : BROWSER_OUTPUT: Values: 771.3 832.7 856.2 944.5 972.3 14606.2 14612.1 14679.0 14852.2 14866.3 14085.9 14103.4 14154.4 14178.9 14191.3 761.2 771.7 771.7 894.2 916.9 922.7 924.9 934.0 934.1 935.0 968.2 977.4 977.4 978.3 978.5 795.9 806.1 945.2 949.7 950.4 705.8 707.3 707.3 709.2 710.8 14123.0 14340.9 14369.4 14377.8 14392.9 12514.4 12736.0 12904.7 12970.2 13008.2 10951.6 11003.7 11775.4 11882.2 12094.5 3815.9 3839.5 3854.3 3888.9 3927.9 44413.1 45058.3 45327.8 45513.8 48844.0 9806.8 9895.2 9902.8 9961.1 10066.3 18754.5 18767.5 18783.4 18789.5 18841.0 8051.2 8317.5 8350.6 8407.5 8555.5 4529.5 4561.7 4567.7 4702.4 4777.0 3256.7 3266.3 3282.1 3288.5 3290.3 596.4 600.6 616.1 616.2 618.7 613.0 669.9 694.3 699.7 722.5 8594.1 8651.2 8751.7 8848.0 8912.3 690.2 695.3 696.4 700.4 715.4 4354.7 4409.3 4511.4 4601.6 4823.3 60299.4 60560.7 60982.7 61822.7 63151.7 56869.9 57185.7 57186.7 57931.0 58687.0 48874.0 48966.5 49093.8 49348.5 49949.8 9597.0 9718.8 9772.9 9932.0 9939.0 35599.6 35667.5 35974.8 36722.0 36736.6 40942.4 41299.0 42100.8 46119.8 46174.5 12101.0 12482.8 12662.4 13499.9 13785.9 13295.3 13366.6 13588.3 14259.8 14313.4 12043.6 12206.5 12391.9 12645.0 12995.3 11986.8 12029.3 12457.9 12543.6 12832.6 11616.4 11774.9 12212.6 12617.8 12812.2 10718.8 10945.3 11015.7 11028.8 11127.3 10689.7 10699.6 10755.4 10863.6 11007.4 14:04:58 INFO - 2016-02-11 14:04:58,487 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:04:58 INFO - 2016-02-11 14:04:58,487 DEBUG : BROWSER_OUTPUT: 14:04:59 INFO - 2016-02-11 14:04:59,066 INFO : Browser exited with error code: 0 14:04:59 INFO - 2016-02-11 14:04:59,084 INFO : Completed test dromaeo_css (00:18:29) 14:04:59 INFO - 2016-02-11 14:04:59,085 INFO : Starting test kraken 14:04:59 INFO - 2016-02-11 14:04:59,085 DEBUG : operating with platform_type : linux_ 14:04:59 INFO - 2016-02-11 14:04:59,085 INFO : Initialising browser for kraken test... 14:04:59 INFO - 2016-02-11 14:04:59,091 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpyjguvI/profile http://localhost:44189/getInfo.html 14:05:02 INFO - 2016-02-11 14:05:02,566 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:05:02 INFO - 2016-02-11 14:05:02,567 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:05:02 INFO - 2016-02-11 14:05:02,567 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 14:05:02 INFO - 2016-02-11 14:05:02,567 DEBUG : BROWSER_OUTPUT: __metrics 14:05:02 INFO - 2016-02-11 14:05:02,704 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:05:03 INFO - 2016-02-11 14:05:03,870 INFO : Browser initialized. 14:05:03 INFO - 2016-02-11 14:05:03,871 INFO : Running cycle 1/1 for kraken test... 14:05:03 INFO - 2016-02-11 14:05:03,871 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpyjguvI/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:05:15 INFO - 2016-02-11 14:05:15,550 DEBUG : BROWSER_OUTPUT: RSS: Main: 133824512 14:05:15 INFO - 2016-02-11 14:05:15,550 DEBUG : BROWSER_OUTPUT: 14:05:17 INFO - 2016-02-11 14:05:17,991 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44189/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44189/tests/kraken/driver.html?testName=audio-beat-detection) 14:05:18 INFO - 2016-02-11 14:05:18,572 DEBUG : BROWSER_OUTPUT: RSS: Main: 164868096 14:05:18 INFO - 2016-02-11 14:05:18,572 DEBUG : BROWSER_OUTPUT: 14:05:21 INFO - 2016-02-11 14:05:21,133 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44189/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44189/tests/kraken/driver.html?testName=audio-dft) 14:05:21 INFO - 2016-02-11 14:05:21,695 DEBUG : BROWSER_OUTPUT: RSS: Main: 162775040 14:05:21 INFO - 2016-02-11 14:05:21,695 DEBUG : BROWSER_OUTPUT: 14:05:24 INFO - 2016-02-11 14:05:24,493 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44189/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44189/tests/kraken/driver.html?testName=audio-fft) 14:05:25 INFO - 2016-02-11 14:05:25,067 DEBUG : BROWSER_OUTPUT: RSS: Main: 161288192 14:05:25 INFO - 2016-02-11 14:05:25,067 DEBUG : BROWSER_OUTPUT: 14:05:27 INFO - 2016-02-11 14:05:27,069 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44189/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44189/tests/kraken/driver.html?testName=audio-oscillator) 14:05:27 INFO - 2016-02-11 14:05:27,635 DEBUG : BROWSER_OUTPUT: RSS: Main: 160362496 14:05:27 INFO - 2016-02-11 14:05:27,635 DEBUG : BROWSER_OUTPUT: 14:05:29 INFO - 2016-02-11 14:05:29,800 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44189/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44189/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:05:30 INFO - 2016-02-11 14:05:30,361 DEBUG : BROWSER_OUTPUT: RSS: Main: 159297536 14:05:30 INFO - 2016-02-11 14:05:30,361 DEBUG : BROWSER_OUTPUT: 14:05:33 INFO - 2016-02-11 14:05:33,219 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44189/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44189/tests/kraken/driver.html?testName=imaging-darkroom) 14:05:33 INFO - 2016-02-11 14:05:33,780 DEBUG : BROWSER_OUTPUT: RSS: Main: 157442048 14:05:33 INFO - 2016-02-11 14:05:33,781 DEBUG : BROWSER_OUTPUT: 14:05:37 INFO - 2016-02-11 14:05:37,113 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44189/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44189/tests/kraken/driver.html?testName=imaging-desaturate) 14:05:37 INFO - 2016-02-11 14:05:37,679 DEBUG : BROWSER_OUTPUT: RSS: Main: 156925952 14:05:37 INFO - 2016-02-11 14:05:37,680 DEBUG : BROWSER_OUTPUT: 14:05:40 INFO - 2016-02-11 14:05:40,357 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44189/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44189/tests/kraken/driver.html?testName=json-parse-financial) 14:05:40 INFO - 2016-02-11 14:05:40,925 DEBUG : BROWSER_OUTPUT: RSS: Main: 158621696 14:05:40 INFO - 2016-02-11 14:05:40,925 DEBUG : BROWSER_OUTPUT: 14:05:42 INFO - 2016-02-11 14:05:42,508 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44189/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44189/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:05:43 INFO - 2016-02-11 14:05:43,070 DEBUG : BROWSER_OUTPUT: RSS: Main: 162471936 14:05:43 INFO - 2016-02-11 14:05:43,070 DEBUG : BROWSER_OUTPUT: 14:05:44 INFO - 2016-02-11 14:05:44,824 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44189/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44189/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:05:45 INFO - 2016-02-11 14:05:45,418 DEBUG : BROWSER_OUTPUT: RSS: Main: 159891456 14:05:45 INFO - 2016-02-11 14:05:45,419 DEBUG : BROWSER_OUTPUT: 14:05:47 INFO - 2016-02-11 14:05:47,417 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44189/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44189/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:05:47 INFO - 2016-02-11 14:05:47,984 DEBUG : BROWSER_OUTPUT: RSS: Main: 167116800 14:05:47 INFO - 2016-02-11 14:05:47,984 DEBUG : BROWSER_OUTPUT: 14:05:50 INFO - 2016-02-11 14:05:50,343 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44189/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44189/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:05:50 INFO - 2016-02-11 14:05:50,924 DEBUG : BROWSER_OUTPUT: RSS: Main: 172425216 14:05:50 INFO - 2016-02-11 14:05:50,925 DEBUG : BROWSER_OUTPUT: 14:05:53 INFO - 2016-02-11 14:05:53,403 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44189/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44189/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:05:53 INFO - 2016-02-11 14:05:53,985 DEBUG : BROWSER_OUTPUT: RSS: Main: 170881024 14:05:53 INFO - 2016-02-11 14:05:53,985 DEBUG : BROWSER_OUTPUT: 14:05:55 INFO - 2016-02-11 14:05:55,627 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44189/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44189/tests/kraken/driver.html?testName=ai-astar) 14:05:55 INFO - 2016-02-11 14:05:55,886 DEBUG : BROWSER_OUTPUT: RSS: Main: 229191680 14:05:55 INFO - 2016-02-11 14:05:55,886 DEBUG : BROWSER_OUTPUT: 14:05:55 INFO - 2016-02-11 14:05:55,887 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:05:55 INFO - 2016-02-11 14:05:55,887 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:05:55 INFO - 2016-02-11 14:05:55,887 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:05:55 INFO - 2016-02-11 14:05:55,887 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:05:55 INFO - 2016-02-11 14:05:55,887 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;111;105;109;111;111;99;109;109;109 14:05:55 INFO - 2016-02-11 14:05:55,887 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;156;122;143;164;122;146;148;126;159;122 14:05:55 INFO - 2016-02-11 14:05:55,887 DEBUG : BROWSER_OUTPUT: |2;audio-dft;159;158;160;160;159;160;159;162;161;165 14:05:55 INFO - 2016-02-11 14:05:55,887 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;70;71;152;73;73;73;71;158;72 14:05:55 INFO - 2016-02-11 14:05:55,888 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;94;135;92;94;97;138;93;92;142 14:05:55 INFO - 2016-02-11 14:05:55,888 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;108;109;109;109;109;110;110;109;109 14:05:55 INFO - 2016-02-11 14:05:55,888 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;146;146;146;146;147;146;146;145;145 14:05:55 INFO - 2016-02-11 14:05:55,888 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;96;95;95;95;96;96;95;96 14:05:55 INFO - 2016-02-11 14:05:55,888 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;57;59;59;58;65;60;58;58;56;56 14:05:55 INFO - 2016-02-11 14:05:55,889 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;65;66;66;66;66;66;67;66;65;65 14:05:55 INFO - 2016-02-11 14:05:55,889 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;76;77;76;77;78;86;84;80;77;77 14:05:55 INFO - 2016-02-11 14:05:55,889 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;117;118;124;115;118;122;122;114;120;113 14:05:55 INFO - 2016-02-11 14:05:55,889 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;135;143;148;148;143;137;146;141;136;132 14:05:55 INFO - 2016-02-11 14:05:55,889 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;63;64;65;63;65;65;62;64;65;63 14:05:55 INFO - 2016-02-11 14:05:55,890 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:05:55 INFO - 2016-02-11 14:05:55,890 DEBUG : BROWSER_OUTPUT: __start_cc_report 14:05:55 INFO - 2016-02-11 14:05:55,890 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,909 14:05:55 INFO - 2016-02-11 14:05:55,890 DEBUG : BROWSER_OUTPUT: __end_cc_report 14:05:55 INFO - 2016-02-11 14:05:55,890 DEBUG : BROWSER_OUTPUT: __startTimestamp1455228355880__endTimestamp 14:05:55 INFO - 2016-02-11 14:05:55,891 DEBUG : BROWSER_OUTPUT: 14:05:55 INFO - 2016-02-11 14:05:55,891 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:05:55 INFO - 2016-02-11 14:05:55,891 DEBUG : BROWSER_OUTPUT: Number of tests: 14 14:05:55 INFO - 2016-02-11 14:05:55,891 DEBUG : BROWSER_OUTPUT: 14:05:55 INFO - 2016-02-11 14:05:55,891 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.20 Median:110.00 stddev:3.68 (3.3%) stddev-sans-first:3.89 14:05:55 INFO - 2016-02-11 14:05:55,891 DEBUG : BROWSER_OUTPUT: Values: 109.0 111.0 105.0 109.0 111.0 111.0 99.0 109.0 109.0 109.0 14:05:55 INFO - 2016-02-11 14:05:55,892 DEBUG : BROWSER_OUTPUT: 14:05:55 INFO - 2016-02-11 14:05:55,892 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:140.80 Median:147.00 stddev:16.54 (11.3%) stddev-sans-first:16.61 14:05:55 INFO - 2016-02-11 14:05:55,892 DEBUG : BROWSER_OUTPUT: Values: 156.0 122.0 143.0 164.0 122.0 146.0 148.0 126.0 159.0 122.0 14:05:55 INFO - 2016-02-11 14:05:55,892 DEBUG : BROWSER_OUTPUT: 14:05:55 INFO - 2016-02-11 14:05:55,893 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.30 Median:160.00 stddev:2.00 (1.3%) stddev-sans-first:2.07 14:05:55 INFO - 2016-02-11 14:05:55,893 DEBUG : BROWSER_OUTPUT: Values: 159.0 158.0 160.0 160.0 159.0 160.0 159.0 162.0 161.0 165.0 14:05:55 INFO - 2016-02-11 14:05:55,894 DEBUG : BROWSER_OUTPUT: 14:05:55 INFO - 2016-02-11 14:05:55,894 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:88.40 Median:71.50 stddev:35.14 (49.2%) stddev-sans-first:36.71 14:05:55 INFO - 2016-02-11 14:05:55,894 DEBUG : BROWSER_OUTPUT: Values: 71.0 70.0 71.0 152.0 73.0 73.0 73.0 71.0 158.0 72.0 14:05:55 INFO - 2016-02-11 14:05:55,894 DEBUG : BROWSER_OUTPUT: 14:05:55 INFO - 2016-02-11 14:05:55,894 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:107.00 Median:93.00 stddev:21.73 (23.4%) stddev-sans-first:22.45 14:05:55 INFO - 2016-02-11 14:05:55,894 DEBUG : BROWSER_OUTPUT: Values: 93.0 94.0 135.0 92.0 94.0 97.0 138.0 93.0 92.0 142.0 14:05:55 INFO - 2016-02-11 14:05:55,895 DEBUG : BROWSER_OUTPUT: 14:05:55 INFO - 2016-02-11 14:05:55,895 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.10 Median:109.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 14:05:55 INFO - 2016-02-11 14:05:55,895 DEBUG : BROWSER_OUTPUT: Values: 109.0 108.0 109.0 109.0 109.0 109.0 110.0 110.0 109.0 109.0 14:05:55 INFO - 2016-02-11 14:05:55,895 DEBUG : BROWSER_OUTPUT: 14:05:55 INFO - 2016-02-11 14:05:55,895 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 14:05:55 INFO - 2016-02-11 14:05:55,895 DEBUG : BROWSER_OUTPUT: Values: 146.0 146.0 146.0 146.0 146.0 147.0 146.0 146.0 145.0 145.0 14:05:55 INFO - 2016-02-11 14:05:55,896 DEBUG : BROWSER_OUTPUT: 14:05:55 INFO - 2016-02-11 14:05:55,896 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 14:05:55 INFO - 2016-02-11 14:05:55,896 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 96.0 95.0 95.0 95.0 96.0 96.0 95.0 96.0 14:05:55 INFO - 2016-02-11 14:05:55,896 DEBUG : BROWSER_OUTPUT: 14:05:55 INFO - 2016-02-11 14:05:55,896 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:58.60 Median:58.50 stddev:2.59 (4.4%) stddev-sans-first:2.68 14:05:55 INFO - 2016-02-11 14:05:55,897 DEBUG : BROWSER_OUTPUT: Values: 57.0 59.0 59.0 58.0 65.0 60.0 58.0 58.0 56.0 56.0 14:05:55 INFO - 2016-02-11 14:05:55,897 DEBUG : BROWSER_OUTPUT: 14:05:55 INFO - 2016-02-11 14:05:55,897 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:65.80 Median:66.00 stddev:0.63 (1.0%) stddev-sans-first:0.60 14:05:55 INFO - 2016-02-11 14:05:55,897 DEBUG : BROWSER_OUTPUT: Values: 65.0 66.0 66.0 66.0 66.0 66.0 67.0 66.0 65.0 65.0 14:05:55 INFO - 2016-02-11 14:05:55,897 DEBUG : BROWSER_OUTPUT: 14:05:55 INFO - 2016-02-11 14:05:55,898 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:78.80 Median:77.50 stddev:3.49 (4.5%) stddev-sans-first:3.55 14:05:55 INFO - 2016-02-11 14:05:55,898 DEBUG : BROWSER_OUTPUT: Values: 76.0 77.0 76.0 77.0 78.0 86.0 84.0 80.0 77.0 77.0 14:05:55 INFO - 2016-02-11 14:05:55,898 DEBUG : BROWSER_OUTPUT: 14:05:55 INFO - 2016-02-11 14:05:55,899 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:118.30 Median:119.00 stddev:3.68 (3.1%) stddev-sans-first:3.88 14:05:55 INFO - 2016-02-11 14:05:55,899 DEBUG : BROWSER_OUTPUT: Values: 117.0 118.0 124.0 115.0 118.0 122.0 122.0 114.0 120.0 113.0 14:05:55 INFO - 2016-02-11 14:05:55,899 DEBUG : BROWSER_OUTPUT: 14:05:55 INFO - 2016-02-11 14:05:55,899 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.90 Median:143.00 stddev:5.67 (4.0%) stddev-sans-first:5.59 14:05:55 INFO - 2016-02-11 14:05:55,899 DEBUG : BROWSER_OUTPUT: Values: 135.0 143.0 148.0 148.0 143.0 137.0 146.0 141.0 136.0 132.0 14:05:55 INFO - 2016-02-11 14:05:55,899 DEBUG : BROWSER_OUTPUT: 14:05:55 INFO - 2016-02-11 14:05:55,899 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.90 Median:64.50 stddev:1.10 (1.7%) stddev-sans-first:1.12 14:05:55 INFO - 2016-02-11 14:05:55,899 DEBUG : BROWSER_OUTPUT: Values: 63.0 64.0 65.0 63.0 65.0 65.0 62.0 64.0 65.0 63.0 14:05:55 INFO - 2016-02-11 14:05:55,899 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:05:55 INFO - 2016-02-11 14:05:55,899 DEBUG : BROWSER_OUTPUT: 14:05:56 INFO - 2016-02-11 14:05:56,543 INFO : Browser exited with error code: 0 14:05:56 INFO - 2016-02-11 14:05:56,596 INFO : Completed test kraken (00:00:57) 14:05:56 INFO - 2016-02-11 14:05:56,596 INFO : Starting test v8_7 14:05:56 INFO - 2016-02-11 14:05:56,596 DEBUG : operating with platform_type : linux_ 14:05:56 INFO - 2016-02-11 14:05:56,596 INFO : Initialising browser for v8_7 test... 14:05:56 INFO - 2016-02-11 14:05:56,602 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp37h8du/profile http://localhost:44189/getInfo.html 14:06:00 INFO - 2016-02-11 14:06:00,546 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:06:00 INFO - 2016-02-11 14:06:00,546 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:06:00 INFO - 2016-02-11 14:06:00,546 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 14:06:00 INFO - 2016-02-11 14:06:00,546 DEBUG : BROWSER_OUTPUT: __metrics 14:06:00 INFO - 2016-02-11 14:06:00,707 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:06:01 INFO - 2016-02-11 14:06:01,582 INFO : Browser initialized. 14:06:01 INFO - 2016-02-11 14:06:01,583 INFO : Running cycle 1/1 for v8_7 test... 14:06:01 INFO - 2016-02-11 14:06:01,583 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp37h8du/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:06:13 INFO - 2016-02-11 14:06:13,265 DEBUG : BROWSER_OUTPUT: RSS: Main: 133742592 14:06:13 INFO - 2016-02-11 14:06:13,265 DEBUG : BROWSER_OUTPUT: 14:06:34 INFO - 2016-02-11 14:06:34,616 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44189/tests/v8_7/run.html (next: http://localhost:44189/tests/v8_7/run.html) 14:06:34 INFO - 2016-02-11 14:06:34,867 DEBUG : BROWSER_OUTPUT: RSS: Main: 420192256 14:06:34 INFO - 2016-02-11 14:06:34,867 DEBUG : BROWSER_OUTPUT: 14:06:34 INFO - 2016-02-11 14:06:34,868 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:06:34 INFO - 2016-02-11 14:06:34,868 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:06:34 INFO - 2016-02-11 14:06:34,869 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:06:34 INFO - 2016-02-11 14:06:34,869 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:06:34 INFO - 2016-02-11 14:06:34,869 DEBUG : BROWSER_OUTPUT: |0;Richards;167.61649346295675 14:06:34 INFO - 2016-02-11 14:06:34,869 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;165.01650165016503 14:06:34 INFO - 2016-02-11 14:06:34,869 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.00945232137894 14:06:34 INFO - 2016-02-11 14:06:34,869 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5154.639175257732 14:06:34 INFO - 2016-02-11 14:06:34,870 DEBUG : BROWSER_OUTPUT: |4;RayTrace;938.0863039399625 14:06:34 INFO - 2016-02-11 14:06:34,870 DEBUG : BROWSER_OUTPUT: |5;Earley;540.2485143165857 14:06:34 INFO - 2016-02-11 14:06:34,870 DEBUG : BROWSER_OUTPUT: |6;Boyer;10902.173913043478 14:06:34 INFO - 2016-02-11 14:06:34,870 DEBUG : BROWSER_OUTPUT: |7;RegExp;24095.238095238095 14:06:34 INFO - 2016-02-11 14:06:34,870 DEBUG : BROWSER_OUTPUT: |8;Splay;525.1572327044025 14:06:34 INFO - 2016-02-11 14:06:34,870 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4826.923076923077 14:06:34 INFO - 2016-02-11 14:06:34,870 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:06:34 INFO - 2016-02-11 14:06:34,871 DEBUG : BROWSER_OUTPUT: __startTimestamp1455228394866__endTimestamp 14:06:34 INFO - 2016-02-11 14:06:34,871 DEBUG : BROWSER_OUTPUT: 14:06:34 INFO - 2016-02-11 14:06:34,871 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:06:34 INFO - 2016-02-11 14:06:34,871 DEBUG : BROWSER_OUTPUT: Number of tests: 10 14:06:34 INFO - 2016-02-11 14:06:34,871 DEBUG : BROWSER_OUTPUT: 14:06:34 INFO - 2016-02-11 14:06:34,871 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:167.62 Median:167.62 stddev:0.00 (0.0%) 14:06:34 INFO - 2016-02-11 14:06:34,872 DEBUG : BROWSER_OUTPUT: Values: 167.6 14:06:34 INFO - 2016-02-11 14:06:34,872 DEBUG : BROWSER_OUTPUT: 14:06:34 INFO - 2016-02-11 14:06:34,872 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:165.02 Median:165.02 stddev:0.00 (0.0%) 14:06:34 INFO - 2016-02-11 14:06:34,872 DEBUG : BROWSER_OUTPUT: Values: 165.0 14:06:34 INFO - 2016-02-11 14:06:34,872 DEBUG : BROWSER_OUTPUT: 14:06:34 INFO - 2016-02-11 14:06:34,872 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.01 Median:278.01 stddev:0.00 (0.0%) 14:06:34 INFO - 2016-02-11 14:06:34,873 DEBUG : BROWSER_OUTPUT: Values: 278.0 14:06:34 INFO - 2016-02-11 14:06:34,873 DEBUG : BROWSER_OUTPUT: 14:06:34 INFO - 2016-02-11 14:06:34,874 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5154.64 Median:5154.64 stddev:0.00 (0.0%) 14:06:34 INFO - 2016-02-11 14:06:34,874 DEBUG : BROWSER_OUTPUT: Values: 5154.6 14:06:34 INFO - 2016-02-11 14:06:34,874 DEBUG : BROWSER_OUTPUT: 14:06:34 INFO - 2016-02-11 14:06:34,874 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:938.09 Median:938.09 stddev:0.00 (0.0%) 14:06:34 INFO - 2016-02-11 14:06:34,874 DEBUG : BROWSER_OUTPUT: Values: 938.1 14:06:34 INFO - 2016-02-11 14:06:34,874 DEBUG : BROWSER_OUTPUT: 14:06:34 INFO - 2016-02-11 14:06:34,874 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:540.25 Median:540.25 stddev:0.00 (0.0%) 14:06:34 INFO - 2016-02-11 14:06:34,875 DEBUG : BROWSER_OUTPUT: Values: 540.2 14:06:34 INFO - 2016-02-11 14:06:34,875 DEBUG : BROWSER_OUTPUT: 14:06:34 INFO - 2016-02-11 14:06:34,875 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10902.17 Median:10902.17 stddev:0.00 (0.0%) 14:06:34 INFO - 2016-02-11 14:06:34,875 DEBUG : BROWSER_OUTPUT: Values: 10902.2 14:06:34 INFO - 2016-02-11 14:06:34,875 DEBUG : BROWSER_OUTPUT: 14:06:34 INFO - 2016-02-11 14:06:34,875 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24095.24 Median:24095.24 stddev:0.00 (0.0%) 14:06:34 INFO - 2016-02-11 14:06:34,875 DEBUG : BROWSER_OUTPUT: Values: 24095.2 14:06:34 INFO - 2016-02-11 14:06:34,875 DEBUG : BROWSER_OUTPUT: 14:06:34 INFO - 2016-02-11 14:06:34,875 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:525.16 Median:525.16 stddev:0.00 (0.0%) 14:06:34 INFO - 2016-02-11 14:06:34,875 DEBUG : BROWSER_OUTPUT: Values: 525.2 14:06:34 INFO - 2016-02-11 14:06:34,875 DEBUG : BROWSER_OUTPUT: 14:06:34 INFO - 2016-02-11 14:06:34,875 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 14:06:34 INFO - 2016-02-11 14:06:34,875 DEBUG : BROWSER_OUTPUT: Values: 4826.9 14:06:34 INFO - 2016-02-11 14:06:34,875 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:06:34 INFO - 2016-02-11 14:06:34,875 DEBUG : BROWSER_OUTPUT: 14:06:35 INFO - 2016-02-11 14:06:35,586 INFO : Browser exited with error code: 0 14:06:35 INFO - 2016-02-11 14:06:35,600 INFO : Completed test v8_7 (00:00:39) 14:06:35 INFO - 2016-02-11 14:06:35,928 INFO : Completed test suite (00:20:06) 14:06:35 INFO - 2016-02-11 14:06:35,928 DEBUG : Working with test: dromaeo_css 14:06:35 INFO - 2016-02-11 14:06:35,928 DEBUG : Generating results file: dromaeo_css 14:06:35 INFO - 2016-02-11 14:06:35,930 DEBUG : Working with test: kraken 14:06:35 INFO - 2016-02-11 14:06:35,930 DEBUG : Generating results file: kraken 14:06:35 INFO - 2016-02-11 14:06:35,930 INFO : javascript benchmark 14:06:35 INFO - 2016-02-11 14:06:35,930 DEBUG : Working with test: v8_7 14:06:35 INFO - 2016-02-11 14:06:35,930 DEBUG : Generating results file: v8_7 14:06:35 INFO - 2016-02-11 14:06:35,931 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:06:35 INFO - 2016-02-11 14:06:35,987 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,53,35]] 14:06:35 INFO - 2016-02-11 14:06:35,987 DEBUG : process_Request line: dromaeo_css 7311.61 graph.html#tests=[[72,53,35]] 14:06:35 INFO - 2016-02-11 14:06:35,987 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:06:36 INFO - 2016-02-11 14:06:36,022 DEBUG : process_Request line: kraken 1481.50 graph.html#tests=[[232,53,35]] 14:06:36 INFO - 2016-02-11 14:06:36,022 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:06:36 INFO - 2016-02-11 14:06:36,056 DEBUG : process_Request line: v8_7 23268.84 graph.html#tests=[[230,53,35]] 14:06:36 INFO - 2016-02-11 14:06:36,057 INFO : javascript benchmark 14:06:36 INFO - 2016-02-11 14:06:36,061 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3264.869405223791, 3318.784279021862, 3336.7497437692177, 3338.732901367891, 3363.512290717845, 5319.92020119698, 5353.91969120463, 5380.461953804617, 5383.327084114486, 5405.081136206844, 5429.185622156679, 5460.235567020621, 5488.341399032111, 5495.6153069285165, 5500.862478438041, 4866.197077482211, 4978.352814134158, 5039.294498770175, 5072.4673909239555, 5100.362454693163, 5026.070177017245, 5092.796288148488, 5095.108356037697, 5095.414027386861, 5098.566621837148, 4960.776765045582, 5004.84985450437, 5065.037642847866, 5066.442691303953, 5072.670276432039, 5005.499450054966, 5028.094942910275, 5080.898382032357, 5110.207917772751, 5118.232265160219, 4942.678725882806, 5043.470435604246, 5058.949410505885, 5083.389993200803, 5085.974570127126, 5237.764300606482, 5289.550388217006, 5300.0459917214885, 5339.439358867341, 5389.595780316492, 5789.942100578983, 5887.205227294303, 5890.440408161261, 5896.823095307148, 5926.940730592682, 5899.764009439617, 5900.881982360329, 5902.468777809975, 5904.527637788967, 5932.377100404438, 5392.379876314235, 5491.697956612345, 5525.861853453695, 5532.861678458031, 5541.002619528484, 6016.909746353808, 6037.54718396122, 6050.606710563799, 6054.303755068136, 6065.848353791191, 5810.331811841692, 5841.970790146022, 5842.2405087338375, 5846.678432686158, 5848.444397782204, 5629.408912064257, 5683.54531637468, 5784.2769653793275, 5861.677607731531, 5903.6457812530525, 5854.063349864001, 5888.499477544371, 5891.646501209942, 5902.675352855634, 5910.586258961831, 5868.941310586925, 5879.176915231871, 5883.382244864313, 5884.0, 5884.0, 4369.169857727022, 4446.688731788744, 4505.098980203972, 4510.751908645056, 4626.537346265414, 4089.815958281825, 4119.773412462283, 4122.752634841919, 4126.91746165075, 4132.33882578792, 5616.803411880564, 5632.211490391349, 5632.3804381518, 5649.4350564944, 5663.716814159276, 5640.492355688008, 5711.657300561979, 5746.712664366849, 5795.681237531976, 5828.562857785683, 5604.523615492729, 5606.103023516218, 5614.775408983676, 5618.97190514053, 5621.100623900156, 4964.478729733398, 5120.948790512047, 5133.820316288912, 5136.43499215086, 5166.948330516647, 6043.8186854394435, 6079.8480037998515, 6178.011518157074, 6178.783742569079, 6183.690815459299, 5954.46409823118, 5956.13636022783, 5956.493698035715, 5958.0, 5964.582479226499, 5891.882162356815, 6002.489788368038, 6133.570650054453, 6150.015997440388, 6153.507719382528, 5671.688057156896, 5723.542116630742, 5724.914126288026, 5738.225339579103, 5766.1350797379055, 5889.411058894077, 5890.793822216202, 5933.0, 5936.436038576328, 5951.285845698544, 5561.5272701820795, 5561.833145005657, 5646.435356464485, 5735.971320143372, 5795.246617939641, 5750.396208398058, 5799.739011744397, 5810.564207684356, 5825.475707186373, 5842.036064049385, 5717.942820571908, 5723.170140329546, 5729.054705973468, 5731.541476681772, 5744.684042377709, 5551.833444996657, 5625.746841392229, 5646.265985421869, 5757.769689212385, 5833.941660583339, 5638.210650509014, 5690.857728556819, 5705.172749951317, 5712.571557133315, 5721.25623668937], "unit": "ms", "name": "dojo.html", "value": 5432.562931420827}, {"lowerIsBetter": false, "replicates": [587.4947545111204, 627.0688028278004, 646.2471221027503, 647.7117682631228, 663.9834004149893, 33719.0, 34520.65479345206, 34534.48198277028, 34571.65428345716, 34577.0, 35340.0, 43461.7826910865, 44203.557964420426, 44207.33688994667, 44338.113237735226, 9337.953310233457, 9440.433573985549, 9478.0, 9479.0, 9485.33602647815, 8179.386546009044, 8372.790680232982, 9032.051634578373, 9068.138526839939, 9197.770055748593, 11246.156538259622, 11541.249818761795, 11548.769024619503, 11549.53801847925, 11554.422278886022, 11079.169062320318, 11125.610603628835, 11193.048590869786, 11203.159763017724, 11206.495707693173, 8390.664373425056, 8641.95679021607, 10900.12798976088, 11207.383593902332, 11543.191976561644, 43458.13083738339, 43734.125317493475, 43812.561874381165, 43894.561054389684, 43911.34132988008, 3564.6435356464403, 3631.400818864884, 3671.6328367163337, 3801.6768574671187, 4109.856155034589, 33414.23220973783, 33584.49623255653, 34113.82943085294, 34530.309393811986, 34830.0, 4327.632151267146, 4343.630791382705, 4370.082282720632, 4383.561643835623, 4447.955520444786, 308503.0, 309275.0, 310109.0, 310405.0, 310490.0, 65412.34587654158, 66644.33355666479, 66881.6655916727, 73527.63236183891, 75236.24763752402, 67054.0, 67205.66397167982, 67497.98753018709, 67590.66204668945, 67632.66183669149, 16961.49115526536, 16997.235124419432, 17015.829841701423, 17034.31862725502, 17075.31698732037, 13937.372818223204, 13965.86034139666, 13967.301634918213, 13972.650683732785, 14123.152610843383, 21964.560708785735, 22042.33872983813, 22296.108155673915, 22307.330780076623, 22355.10579576831, 7386.2613738625705, 7652.196519365498, 7677.0, 7689.307962283421, 7736.381089512825, 1053.5785685725618, 1099.455769394155, 1115.754534002518, 1141.9828702569469, 1193.2482536002262, 29877.850610747242, 30289.394212115636, 30989.690103099132, 31456.0, 31482.0, 1132.5639628742829, 1162.2213117211488, 1164.4294295795, 1179.8820117988132, 1213.9210951288137, 14116.647083822781, 14490.203038832966, 14517.637059073397, 14605.85394146045, 16385.91807040981, 268960.0, 269685.0, 269950.0, 273132.0, 273432.0, 56902.14646780302, 57609.42390576124, 57779.0, 57882.42117578854, 57976.4202357971, 1343.7446885091802, 1364.0860623382357, 1364.9249291288875, 1402.3479082226813, 1429.2996431748368, 27793.0, 27973.571581960176, 28496.57255141216, 30035.69964300329, 30044.11976356923, 47553.52446475491, 47582.28626570535, 47596.0, 47814.0, 48010.75994620004, 242680.0, 243927.0, 244076.0, 244269.0, 244376.0, 33523.1619209512, 33736.83131584425, 33782.0, 34031.4895276576, 34121.658783412844, 46255.0, 46388.30417543807, 46406.53593464022, 47122.76438617785, 47387.52612473831, 35671.28657426889, 35796.463053054744, 37733.4339984895, 38479.807600961816, 39305.213895721354, 38505.229895402495, 39070.467439626875, 39104.2179156421, 39213.21573568456, 39689.0, 38286.42570361502, 38557.228855423295, 38557.807210963765, 38559.6144038556, 38628.034299142746, 33920.15199620029, 34582.30835383329, 35310.0, 35860.282794344486, 35885.461718074774, 26519.469610608066, 26838.463230734884, 27194.320141995817, 27220.183394498195, 27478.45043099087], "unit": "ms", "name": "ext.html", "value": 19851.84609928199}, {"lowerIsBetter": false, "replicates": [362.9655182757639, 364.3678218291264, 368.0981595092025, 370.549782014852, 371.40945896025323, 14771.261436928164, 16018.439354622591, 17482.56293592661, 19006.334778282762, 19781.40655780329, 17192.312307507716, 17246.31014759411, 17472.0, 17636.911815440904, 17680.557986050324, 5598.104303311471, 5719.971400142994, 5735.053716136832, 5745.0, 5748.597598168109, 4332.415123958257, 4439.578240067189, 5623.044082505984, 6138.14066030756, 6315.715792789336, 6089.238845144357, 6204.720787564571, 6230.501559875222, 6260.4991600672065, 6260.812175634738, 6276.68616569172, 6308.432241098278, 6309.558330916838, 6311.747530098791, 6317.77887773928, 5378.757955891994, 5466.371367292732, 5487.670739755627, 5490.231367608538, 5492.368377636543, 22081.116755329927, 22191.889040554855, 22239.22162724297, 22481.662775058387, 22657.09371625133, 2270.3075561953597, 2329.94175145621, 2337.2754446121585, 2359.2922123362923, 2427.2475532584954, 13642.931785341108, 13852.722945541134, 14167.149971001772, 14199.78700319496, 14436.422543098264, 1896.82928536431, 1919.4721451600783, 1930.8744931579542, 1948.1038722187811, 2017.979820201794, 64526.0, 66212.0, 66231.0, 66476.66761666161, 67754.32245677529, 9762.438009918522, 9919.0, 10022.0, 10038.447885366375, 10113.848292275621, 12818.871811281955, 12943.0, 12995.0, 13005.609831705064, 13019.153755006084, 7914.683412663429, 8059.355251579859, 8063.758087257392, 8160.102388737234, 8376.49741015541, 8083.1916808319875, 8127.471714338549, 8139.593020349077, 8171.387145964077, 8208.0, 6104.497683916885, 6105.145279660851, 6120.846978825565, 6128.724207410677, 6291.182146321041, 1614.2090375715816, 1635.2641311409914, 1684.1663376628646, 1724.5257554172704, 1746.5371676505736, 955.5938726041404, 964.6045121500291, 1018.2719355660738, 1087.7389426537575, 1096.4736926275273, 16998.150092495325, 17444.215010324566, 17606.0, 17753.201105950262, 17863.73204401935, 1025.707673313117, 1046.6179844356907, 1068.2682362581656, 1080.5137688040413, 1107.2636696596835, 10152.441615711206, 10337.17302615804, 10391.064804167661, 10408.895911040943, 10467.947660261802, 477348.0, 630442.0, 632033.0, 639300.0, 658633.0, 79175.60412197902, 85202.99999999876, 85622.0, 87994.0, 88369.11630883609, 1243.6828608704723, 1244.0918129765323, 1295.6890346317005, 1305.9020573457028, 1333.466613354666, 15564.610884727972, 16033.679326413174, 16352.67294654124, 16410.179491025163, 16485.752713709542, 33833.66166338305, 37435.812820935724, 37529.6247037537, 37727.81136094302, 38976.80511597424, 40966.0, 43760.781196095086, 45211.773941130086, 48695.26957095717, 48871.0, 9169.083091690778, 9323.254139668947, 9404.0, 9479.47862867549, 9495.14543691071, 17416.73874891903, 17763.200655970253, 17873.553161170556, 17905.731414029062, 17977.280908763503, 14043.50847720325, 14098.859011409755, 14653.194074326015, 14726.354237974145, 15055.473058442902, 15187.696246075238, 15409.229538523254, 15526.689466210839, 15756.842431575538, 16113.758293625839, 15685.686286274438, 15896.76154857655, 15999.440019599258, 16154.192290385668, 16303.67392652164, 9501.192398645917, 9548.236141108833, 9561.61753529851, 9576.76058098553, 9613.182879455324, 15304.617384565476, 15450.150241736812, 15501.379944802082, 15544.766828497808, 15807.446739364066], "unit": "ms", "name": "jquery.html", "value": 9561.090088853782}, {"lowerIsBetter": false, "replicates": [1531.5941275561975, 1600.0239853689252, 1634.6894090122883, 1748.7551742756016, 1870.0743132149587, 7289.599072051035, 7490.88763668544, 7495.475316727831, 7498.700051997927, 7502.0, 6811.761588344409, 7002.124734408199, 7002.369786719194, 7005.474589405802, 7412.258774122599, 2171.771963943791, 2195.4401627584944, 2215.4904371994453, 2217.6119179143666, 2219.3009202101366, 2317.6639387288833, 2332.7200735911715, 2386.331827088409, 2389.581823180936, 2391.1033362489065, 1999.3102379678987, 2038.042120203502, 2253.740819805727, 2309.0, 2365.219477572397, 2267.455810605459, 2274.7384050834116, 2276.044061494168, 2282.486440550888, 2283.646034864582, 2221.2891874600136, 2222.5999320122373, 2228.5877112734033, 2241.7421996470453, 2243.887805609713, 7808.375329973588, 7847.6860925562905, 7858.921410785876, 7902.209779022051, 7903.644336004836, 4605.8024913522395, 4656.32483289921, 4657.441107067174, 4719.811207551694, 4734.739589322586, 2979.970200297991, 3039.1642298368124, 3095.4273459409856, 3114.143610507106, 3116.9064928052194, 1021.8262895307815, 1028.0798685176799, 1041.0890470838017, 1041.671873359889, 1071.8017166824163, 10551.47242637865, 10572.735681607945, 10587.470626468723, 10587.576496940113, 10606.310589811716, 4221.176870510221, 4230.069384735353, 4266.935995960063, 4270.252705776476, 4283.678724095706, 8992.280617550581, 9046.547672616343, 9078.591463384164, 9080.0, 9095.772605684779, 4767.594754445911, 4767.976160119178, 4772.0217355442055, 4774.474807771142, 4775.594074503706, 4367.2575662137515, 4380.6057454829215, 4382.430284063052, 4383.693141480066, 4384.364267181241, 3682.0426689061037, 3725.0, 3753.7184711146774, 3753.9624603753614, 3759.49246851677, 1115.9442027898572, 1124.7919134959895, 1128.7414532795874, 1133.2633788037842, 1143.6054561176381, 981.6122631560494, 987.2940847294219, 1016.2378216337746, 1036.4247842447364, 1160.7272291011604, 7322.633868306563, 7389.8152546186775, 7396.149442814038, 7399.038125043709, 7400.851982960311, 1183.2427246562206, 1184.1000839362148, 1206.5294535131306, 1208.9818652720217, 1224.773416917873, 5890.676012819336, 5931.11033344993, 5959.046552551657, 5959.314678811992, 5960.910586341209, 8500.702475413455, 8596.914030859736, 8598.613062412081, 8714.433561818461, 8723.214910658071, 8584.270337021424, 8590.65637374498, 8603.09667484905, 8604.0965698602, 8605.397622166389, 7023.719051237893, 7090.6100164491445, 7303.233160518175, 7303.817404564822, 7307.963460182665, 7431.108267007994, 7460.776176714708, 7546.962265188639, 7558.433117516099, 7566.962165189138, 8409.95795021021, 8471.788205294917, 8476.449030812977, 8642.524661143447, 8658.78353041179, 8615.0, 8633.179847914438, 8787.033426323227, 8805.295576354005, 8809.163129502687, 6651.534392592472, 6695.832604184934, 6704.497162712719, 6705.396514313735, 6706.899396509154, 7327.74352897646, 7368.0, 7371.8157046074275, 7374.446916481178, 7378.409727221917, 6939.930600694131, 7280.817979550554, 7295.124585049828, 7340.632968351668, 7361.079865016873, 6242.222111603473, 6422.743090276336, 6797.0823938767635, 6829.317068293131, 6939.826504337432, 6734.0, 6795.218549866829, 6799.558028728117, 6800.557963732342, 6818.420434263143, 6321.936780632135, 6335.524835637253, 6336.334684858023, 6339.809805705836, 6431.131797207504, 6513.283538810632, 6556.901646475211, 6556.967215163893, 6557.868842623026, 6560.44236239925], "unit": "ms", "name": "mootools.html", "value": 4459.57622673005}, {"lowerIsBetter": false, "replicates": [341.3037403696459, 341.4604924219733, 342.87999200279904, 346.4750902382889, 351.5675718865794, 5868.794592189274, 6048.818535443933, 6050.878982420349, 6059.606125601833, 6107.389261073896, 5837.678927658977, 6024.9698751506185, 6035.879282414349, 6049.2136022317145, 6055.455009049185, 4671.0, 4672.462666793312, 4677.602403795681, 4685.039566888797, 4686.390769199999, 4468.6425085993205, 4526.524714904937, 4587.770611469413, 4623.884402889921, 4672.229082201433, 4590.908181836361, 4591.357209990604, 4596.655250856199, 4616.053708989666, 4618.261078227484, 4592.6555508337005, 4608.009278005245, 4611.054733779601, 4611.354410382549, 4620.214563524209, 4037.6971727120585, 4047.8785636430953, 4061.776602286873, 4063.97968010161, 4069.938950915709, 5689.118186681071, 5744.8851022979725, 5745.913811292792, 5758.136279558058, 5771.624844385144, 5419.214213938996, 5429.425466614677, 5431.375391829951, 5433.347998240237, 5440.319960004999, 6183.227096612924, 6410.519211059142, 6418.967905160491, 6425.582337148117, 6426.807195784134, 4378.64970802335, 4413.933790993137, 4524.864254072383, 4528.139653465831, 4533.886652833673, 6702.83242918926, 6736.730530778763, 6739.056532085512, 6741.157355330583, 6745.93254067453, 4622.514635963243, 4632.166210082218, 4636.165490211794, 4638.257878739386, 4642.9767851161205, 4440.822367105279, 4543.409356783597, 4607.76961151941, 4683.81264749413, 4691.5308469152815, 5351.491608297206, 5355.437679043722, 5358.544523715528, 5365.946340536622, 5366.114591092504, 6503.8699226015215, 6505.186851643544, 6520.076577409675, 6526.314736952647, 6526.902096468557, 1588.1979600301775, 1602.5352647732261, 1604.3181647799638, 1604.6549991751829, 1612.5323656139587, 986.6990567876867, 996.1035068438464, 1001.5493028137367, 1066.5520481397832, 1094.1684319916762, 5733.140028995684, 6181.567290289727, 6246.781362652286, 6316.336784637547, 6422.6467544285515, 6658.766943156967, 6803.353681400358, 6804.6257455840405, 6816.318368163144, 6825.931740682529, 6388.425041746265, 6398.968005160037, 6402.679866006681, 6404.647744374104, 6411.871762564816, 3601.819909004539, 3659.7621154624862, 3661.9450708239397, 3664.0839790052487, 3664.303782281358, 6891.0, 7055.2239253682055, 7060.18807837095, 7065.1521817382245, 7066.293370662893, 6955.408790252784, 6957.1651401832105, 6963.164420269499, 6965.547239429421, 6966.407855332252, 6775.288594697585, 7036.472264580177, 7038.225795162528, 7059.117610298713, 7061.329173728487, 6464.385883341075, 6578.967105164444, 6625.0, 6756.256811750605, 6759.695813688494, 6685.228414470266, 6698.765543205965, 6713.026611141455, 6720.932790672031, 6727.360900714424, 6993.0908981832035, 7000.964995174992, 7004.0, 7004.509684322048, 7012.088428504262, 4448.0, 4503.166914120898, 4548.909021819479, 4566.748828814447, 4572.725636461823, 6667.166604174478, 6720.294369091175, 6723.310675729552, 6726.899096513458, 6736.66316684154, 6538.8365290868105, 6552.63960482178, 6554.573952693059, 6558.114654521579, 6567.31043240472, 6418.711157997808, 6520.706568204537, 6527.05357723137, 6565.441937435371, 6574.638394888327, 6455.774047908489, 6472.029195620695, 6477.967610161919, 6484.1894763154605, 6484.448821850006, 6602.438792702674, 6606.471482281502, 6616.900746488903, 6620.073189753534, 6620.139381880324, 6305.337939516285, 6426.742930282736, 6492.220933488012, 6498.155239818793, 6499.610023398611], "unit": "ms", "name": "prototype.html", "value": 4885.874988134938}, {"lowerIsBetter": false, "replicates": [771.3289438188776, 832.7418500264919, 856.242225630317, 944.5371767833759, 972.3485264872537, 14606.19665918374, 14612.123272603638, 14679.0, 14852.183129927864, 14866.256687165625, 14085.859141408582, 14103.435862565486, 14154.363053662584, 14178.858211417883, 14191.290435478237, 761.1779278379365, 771.7028943856627, 771.7183228121723, 894.1952242981304, 916.9083091690844, 922.7001224602031, 924.8705181274627, 934.009949453578, 934.0845970948441, 935.046252822121, 968.1963969904962, 977.4037836919473, 977.4086677560081, 978.3151793744372, 978.5303054533828, 795.932345750612, 806.1253539909176, 945.1965829045325, 949.7340744591526, 950.4202436513721, 705.7812078255757, 707.2750430808411, 707.2785758526326, 709.2269426325279, 710.8436144048301, 14123.0, 14340.856591434056, 14369.425222991067, 14377.78433323501, 14392.856071439257, 12514.3742812859, 12736.0, 12904.741905161938, 12970.156939798882, 13008.154469959518, 10951.616693415772, 11003.669889903236, 11775.352355620438, 11882.168248222628, 12094.516219351215, 3815.923681526354, 3839.4816699745734, 3854.2869569129803, 3888.8833334999995, 3927.8821635350987, 44413.111737765386, 45058.32412513815, 45327.77336113331, 45513.77243113763, 48843.99999999964, 9806.803863922823, 9895.208383329316, 9902.752431189278, 9961.103500684972, 10066.345687530433, 18754.531136721693, 18767.530811729815, 18783.436496905113, 18789.530261743294, 18841.0, 8051.2351326623875, 8317.459365141367, 8350.62422191003, 8407.45351552147, 8555.486670799772, 4529.547045295444, 4561.680682352204, 4567.703099298535, 4702.435707715096, 4776.95223047772, 3256.739460843127, 3266.2977459846247, 3282.113829266085, 3288.539604455378, 3290.276139249361, 596.4035964035965, 600.6246096189882, 616.1158737212115, 616.1743264026227, 618.6937465954381, 613.0099888679839, 669.8626781509779, 694.3334398977039, 699.720111955222, 722.5375759513915, 8594.054653988056, 8651.178138076873, 8751.693690720795, 8848.0, 8912.331575131891, 690.1511141296234, 695.3394275438354, 696.3663066609463, 700.4431476975816, 715.3990647855826, 4354.695171337976, 4409.316555933835, 4511.390962220124, 4601.562851529099, 4823.300621409876, 60299.39700602938, 60560.697196513735, 60982.69508652517, 61822.69088654528, 63151.6842415785, 56869.87215703176, 57185.71407143021, 57186.7140664294, 57931.0, 58687.0, 48874.02251955012, 48966.510334896906, 49093.75453122783, 49348.50651493511, 49949.750251249236, 9596.95201523988, 9718.805623887623, 9772.853407198756, 9931.950340248253, 9939.0, 35599.64400355963, 35667.46498802468, 35974.820125899205, 36722.0, 36736.63263367439, 40942.38586421266, 41299.0, 42100.789496052326, 46119.76940115278, 46174.53825461702, 12101.0, 12482.812757808822, 12662.430190641258, 13499.86500134986, 13785.931070344985, 13295.268760218281, 13366.599002029954, 13588.25264610456, 14259.786103208253, 14313.355898984779, 12043.578474753342, 12206.450709718261, 12391.93804030974, 12645.0, 12995.28525931083, 11986.76026479483, 12029.338386388483, 12457.875421246034, 12543.56097536582, 12832.615021549369, 11616.361100139573, 11774.882251177722, 12212.57255996036, 12617.81073283883, 12812.167209131376, 10718.785624287315, 10945.343279403261, 11015.72460688457, 11028.779424411627, 11127.276727012719, 10689.732756681145, 10699.625513107005, 10755.408452535186, 10863.619773307897, 11007.394593297446], "unit": "ms", "name": "yui.html", "value": 6799.658796901044}], "name": "dromaeo_css", "value": 7311.607241598532}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 111.0, 105.0, 109.0, 111.0, 111.0, 99.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "ai-astar", "value": 108.2}, {"lowerIsBetter": true, "replicates": [156.0, 122.0, 143.0, 164.0, 122.0, 146.0, 148.0, 126.0, 159.0, 122.0], "unit": "ms", "name": "audio-beat-detection", "value": 140.8}, {"lowerIsBetter": true, "replicates": [159.0, 158.0, 160.0, 160.0, 159.0, 160.0, 159.0, 162.0, 161.0, 165.0], "unit": "ms", "name": "audio-dft", "value": 160.3}, {"lowerIsBetter": true, "replicates": [71.0, 70.0, 71.0, 152.0, 73.0, 73.0, 73.0, 71.0, 158.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 88.4}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 135.0, 92.0, 94.0, 97.0, 138.0, 93.0, 92.0, 142.0], "unit": "ms", "name": "audio-oscillator", "value": 107.0}, {"lowerIsBetter": true, "replicates": [109.0, 108.0, 109.0, 109.0, 109.0, 109.0, 110.0, 110.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.1}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 145.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.9}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [57.0, 59.0, 59.0, 58.0, 65.0, 60.0, 58.0, 58.0, 56.0, 56.0], "unit": "ms", "name": "json-parse-financial", "value": 58.6}, {"lowerIsBetter": true, "replicates": [65.0, 66.0, 66.0, 66.0, 66.0, 66.0, 67.0, 66.0, 65.0, 65.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 65.8}, {"lowerIsBetter": true, "replicates": [76.0, 77.0, 76.0, 77.0, 78.0, 86.0, 84.0, 80.0, 77.0, 77.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 78.8}, {"lowerIsBetter": true, "replicates": [117.0, 118.0, 124.0, 115.0, 118.0, 122.0, 122.0, 114.0, 120.0, 113.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 118.3}, {"lowerIsBetter": true, "replicates": [135.0, 143.0, 148.0, 148.0, 143.0, 137.0, 146.0, 141.0, 136.0, 132.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 140.9}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 65.0, 63.0, 65.0, 65.0, 62.0, 64.0, 65.0, 63.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 63.9}], "name": "kraken", "value": 1481.5000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.61649346295675], "unit": "score", "name": "Richards", "value": 210.61173199999993}, {"lowerIsBetter": false, "replicates": [165.01650165016503], "unit": "score", "name": "DeltaBlue", "value": 400.6750800000002}, {"lowerIsBetter": false, "replicates": [278.00945232137894], "unit": "score", "name": "Encrypt", "value": 957.4530570000002}, {"lowerIsBetter": false, "replicates": [5154.639175257732], "unit": "score", "name": "Decrypt", "value": 51.63911399999997}, {"lowerIsBetter": false, "replicates": [938.0863039399625], "unit": "score", "name": "RayTrace", "value": 788.8282739999999}, {"lowerIsBetter": false, "replicates": [540.2485143165857], "unit": "score", "name": "Earley", "value": 1233.6230130000004}, {"lowerIsBetter": false, "replicates": [10902.173913043478], "unit": "score", "name": "Boyer", "value": 61.131202392821535}, {"lowerIsBetter": false, "replicates": [24095.238095238095], "unit": "score", "name": "RegExp", "value": 37.80767786561265}, {"lowerIsBetter": false, "replicates": [525.1572327044025], "unit": "score", "name": "Splay", "value": 155.1744790419162}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 23268.84461952134}]} 14:06:36 INFO - RETURN: dromaeo_css: 7311.61 14:06:36 INFO - RETURN: kraken: 1481.50 14:06:36 INFO - RETURN: v8_7: 23268.84 14:06:36 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,53,35]]", "result": "23268.84"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,53,35]]", "result": "1481.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,53,35]]", "result": "7311.61"}}} 14:06:36 INFO - Return code: 0 14:06:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 14:06:36 INFO - # TBPL SUCCESS # 14:06:36 INFO - Running post-action listener: _resource_record_post_action 14:06:36 INFO - Running post-run listener: _resource_record_post_run 14:06:37 INFO - Total resource usage - Wall time: 1223s; CPU: 13.0%; Read bytes: 323584; Write bytes: 506134528; Read time: 196; Write time: 373908 14:06:37 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 4096; Write bytes: 246427648; Read time: 96; Write time: 234412 14:06:37 INFO - run-tests - Wall time: 1208s; CPU: 13.0%; Read bytes: 319488; Write bytes: 259706880; Read time: 100; Write time: 139496 14:06:37 INFO - Running post-run listener: _upload_blobber_files 14:06:37 INFO - Blob upload gear active. 14:06:37 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 14:06:37 INFO - Copying logs to upload dir... 14:06:37 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1253.638345 ========= master_lag: 26.22 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-02-11 14:07:03.124942) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-02-11 14:07:03.128506) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1455227141.317725-2090178529 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455217714/firefox-45.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010060 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455217714/firefox-45.0.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.61 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2016-02-11 14:07:03.746626) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 14:07:03.747116) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1455227141.317725-2090178529 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004555 ========= master_lag: 0.46 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 14:07:04.209434) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-11 14:07:04.209803) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-11 14:07:04.210480) ========= ========= Total master_lag: 27.45 =========