builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-069 starttime: 1456448678.25 results: success (0) buildid: 20160225131928 builduid: af6bdb28997444fdb30c4be530f84ce9 revision: 86b07e82b741 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-25 17:04:38.254039) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-25 17:04:38.254467) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-25 17:04:38.254776) ========= 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=1861a34ebfea852630dec091000001fa-1456447534.865157-1401355038 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.009179 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-25 17:04:38.294130) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-25 17:04:38.294919) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-25 17:04:38.361461) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 17:04:38.361832) ========= 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=1861a34ebfea852630dec091000001fa-1456447534.865157-1401355038 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004567 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 17:04:38.417282) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-25 17:04:38.417554) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-25 17:04:38.417942) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 17:04:38.418225) ========= 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=1861a34ebfea852630dec091000001fa-1456447534.865157-1401355038 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-25 17:04:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 227M=0s 2016-02-25 17:04:39 (227 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.166871 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 17:04:38.597153) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 17:04:38.597458) ========= 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=1861a34ebfea852630dec091000001fa-1456447534.865157-1401355038 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017057 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 17:04:38.652055) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 17:04:38.652365) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 86b07e82b741 --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 86b07e82b741 --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=1861a34ebfea852630dec091000001fa-1456447534.865157-1401355038 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-25 17:04:39,383 Setting DEBUG logging. 2016-02-25 17:04:39,384 attempt 1/10 2016-02-25 17:04:39,384 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/86b07e82b741?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-25 17:04:39,656 unpacking tar archive at: mozilla-beta-86b07e82b741/testing/mozharness/ program finished with exit code 0 elapsedTime=0.575234 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 17:04:39.239650) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-25 17:04:39.239959) ========= echo 86b07e82b741 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'86b07e82b741'] 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=1861a34ebfea852630dec091000001fa-1456447534.865157-1401355038 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 86b07e82b741 program finished with exit code 0 elapsedTime=0.003311 script_repo_revision: '86b07e82b741' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-25 17:04:39.288076) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-25 17:04:39.288377) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-25 17:04:39.298041) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2016-02-25 17:04:39.298316) ========= /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=1861a34ebfea852630dec091000001fa-1456447534.865157-1401355038 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:04:40 INFO - MultiFileLogger online at 20160225 17:04:40 in /builds/slave/test-pgo 17:04:40 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 17:04:40 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 17:04:40 INFO - {'append_to_log': False, 17:04:40 INFO - 'base_work_dir': '/builds/slave/test-pgo', 17:04:40 INFO - 'blob_upload_branch': 'Mozilla-Beta', 17:04:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 17:04:40 INFO - 'branch': 'Mozilla-Beta', 17:04:40 INFO - 'buildbot_json_path': 'buildprops.json', 17:04:40 INFO - 'config_files': ('talos/linux_config.py',), 17:04:40 INFO - 'default_actions': ('clobber', 17:04:40 INFO - 'read-buildbot-config', 17:04:40 INFO - 'download-and-extract', 17:04:40 INFO - 'populate-webroot', 17:04:40 INFO - 'create-virtualenv', 17:04:40 INFO - 'install', 17:04:40 INFO - 'run-tests'), 17:04:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:04:40 INFO - 'download_minidump_stackwalk': True, 17:04:40 INFO - 'download_symbols': 'ondemand', 17:04:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:04:40 INFO - 'tooltool.py': '/tools/tooltool.py', 17:04:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:04:40 INFO - '/tools/misc-python/virtualenv.py')}, 17:04:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:04:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:04:40 INFO - 'installer_path': 'installer.exe', 17:04:40 INFO - 'log_level': 'info', 17:04:40 INFO - 'log_name': 'talos', 17:04:40 INFO - 'log_to_console': True, 17:04:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:04:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:04:40 INFO - 'opt_config_files': (), 17:04:40 INFO - 'pip_index': False, 17:04:40 INFO - 'sps_profile': False, 17:04:40 INFO - 'sps_profile_interval': 0, 17:04:40 INFO - 'suite': 'dromaeojs', 17:04:40 INFO - 'system_bits': '32', 17:04:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:04:40 INFO - 'title': 'talos-linux64-ix-069', 17:04:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:04:40 INFO - 'use_talos_json': True, 17:04:40 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 17:04:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:04:40 INFO - 'work_dir': 'build'} 17:04:40 INFO - ##### 17:04:40 INFO - ##### Running clobber step. 17:04:40 INFO - ##### 17:04:40 INFO - Running pre-action listener: _resource_record_pre_action 17:04:40 INFO - Running main action method: clobber 17:04:40 INFO - rmtree: /builds/slave/test-pgo/build 17:04:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 17:04:41 INFO - Running post-action listener: _resource_record_post_action 17:04:41 INFO - ##### 17:04:41 INFO - ##### Running read-buildbot-config step. 17:04:41 INFO - ##### 17:04:41 INFO - Running pre-action listener: _resource_record_pre_action 17:04:41 INFO - Running main action method: read_buildbot_config 17:04:41 INFO - Using buildbot properties: 17:04:41 INFO - { 17:04:41 INFO - "properties": { 17:04:41 INFO - "buildnumber": 136, 17:04:41 INFO - "product": "firefox", 17:04:41 INFO - "script_repo_revision": "production", 17:04:41 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 17:04:41 INFO - "repository": "", 17:04:41 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 17:04:41 INFO - "buildid": "20160225131928", 17:04:41 INFO - "slavename": "talos-linux64-ix-069", 17:04:41 INFO - "pgo_build": "True", 17:04:41 INFO - "basedir": "/builds/slave/test-pgo", 17:04:41 INFO - "project": "", 17:04:41 INFO - "platform": "ubuntu64_hw", 17:04:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:04:41 INFO - "slavebuilddir": "test", 17:04:41 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 17:04:41 INFO - "branch": "mozilla-beta", 17:04:41 INFO - "repo_path": "releases/mozilla-beta", 17:04:41 INFO - "stage_platform": "linux64-pgo", 17:04:41 INFO - "builduid": "af6bdb28997444fdb30c4be530f84ce9", 17:04:41 INFO - "revision": "86b07e82b741" 17:04:41 INFO - }, 17:04:41 INFO - "sourcestamp": { 17:04:41 INFO - "repository": "", 17:04:41 INFO - "hasPatch": false, 17:04:41 INFO - "project": "", 17:04:41 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 17:04:41 INFO - "changes": [ 17:04:41 INFO - { 17:04:41 INFO - "category": null, 17:04:41 INFO - "files": [ 17:04:41 INFO - { 17:04:41 INFO - "url": null, 17:04:41 INFO - "name": "http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456435168/firefox-45.0.en-US.linux-x86_64.tar.bz2" 17:04:41 INFO - } 17:04:41 INFO - ], 17:04:41 INFO - "repository": "", 17:04:41 INFO - "rev": "86b07e82b741", 17:04:41 INFO - "who": "sendchange", 17:04:41 INFO - "when": 1456448585, 17:04:41 INFO - "number": 7656584, 17:04:41 INFO - "comments": "Backed out changeset 2767f381c592 (bug 1224875) for site compat issue a=sylvestre", 17:04:41 INFO - "project": "", 17:04:41 INFO - "at": "Thu 25 Feb 2016 17:03:05", 17:04:41 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 17:04:41 INFO - "revlink": "", 17:04:41 INFO - "properties": [ 17:04:41 INFO - [ 17:04:41 INFO - "buildid", 17:04:41 INFO - "20160225131928", 17:04:41 INFO - "Change" 17:04:41 INFO - ], 17:04:41 INFO - [ 17:04:41 INFO - "builduid", 17:04:41 INFO - "af6bdb28997444fdb30c4be530f84ce9", 17:04:41 INFO - "Change" 17:04:41 INFO - ], 17:04:41 INFO - [ 17:04:41 INFO - "pgo_build", 17:04:41 INFO - "True", 17:04:41 INFO - "Change" 17:04:41 INFO - ] 17:04:41 INFO - ], 17:04:41 INFO - "revision": "86b07e82b741" 17:04:41 INFO - } 17:04:41 INFO - ], 17:04:41 INFO - "revision": "86b07e82b741" 17:04:41 INFO - } 17:04:41 INFO - } 17:04:41 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456435168/firefox-45.0.en-US.linux-x86_64.tar.bz2. 17:04:41 INFO - Running post-action listener: _resource_record_post_action 17:04:41 INFO - ##### 17:04:41 INFO - ##### Running download-and-extract step. 17:04:41 INFO - ##### 17:04:41 INFO - Running pre-action listener: _resource_record_pre_action 17:04:41 INFO - Running main action method: download_and_extract 17:04:41 INFO - mkdir: /builds/slave/test-pgo/build/tests 17:04:41 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')]} 17:04:41 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456435168/test_packages.json 17:04:41 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456435168/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 17:04:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456435168/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 17:04:41 INFO - Downloaded 1270 bytes. 17:04:41 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 17:04:41 INFO - Using the following test package requirements: 17:04:41 INFO - {u'common': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 17:04:41 INFO - u'cppunittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 17:04:41 INFO - u'firefox-45.0.en-US.linux-x86_64.cppunittest.tests.zip'], 17:04:41 INFO - u'jittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 17:04:41 INFO - u'jsshell-linux-x86_64.zip'], 17:04:41 INFO - u'mochitest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 17:04:41 INFO - u'firefox-45.0.en-US.linux-x86_64.mochitest.tests.zip'], 17:04:41 INFO - u'mozbase': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 17:04:41 INFO - u'reftest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 17:04:41 INFO - u'firefox-45.0.en-US.linux-x86_64.reftest.tests.zip'], 17:04:41 INFO - u'talos': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 17:04:41 INFO - u'firefox-45.0.en-US.linux-x86_64.talos.tests.zip'], 17:04:41 INFO - u'web-platform': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 17:04:41 INFO - u'firefox-45.0.en-US.linux-x86_64.web-platform.tests.zip'], 17:04:41 INFO - u'webapprt': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 17:04:41 INFO - u'xpcshell': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 17:04:41 INFO - u'firefox-45.0.en-US.linux-x86_64.xpcshell.tests.zip']} 17:04:41 INFO - Downloading packages: [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:04:41 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')]} 17:04:41 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456435168/firefox-45.0.en-US.linux-x86_64.common.tests.zip 17:04:41 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456435168/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 17:04:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456435168/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 17:04:41 INFO - Downloaded 21584480 bytes. 17:04:41 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 17:04:41 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 17:04:41 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 17:04:42 INFO - Return code: 0 17:04:42 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 17:04:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:42 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456435168/firefox-45.0.en-US.linux-x86_64.common.tests.zip 17:04:42 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456435168/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 17:04:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456435168/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 17:04:43 INFO - Downloaded 21584480 bytes. 17:04:43 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 17:04:43 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 17:04:43 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 17:04:44 INFO - Return code: 0 17:04: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')]} 17:04:44 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456435168/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 17:04:44 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456435168/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 17:04:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456435168/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 17:04:46 INFO - Downloaded 11132038 bytes. 17:04:46 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 17:04:46 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 17:04:46 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 17:04:46 INFO - Return code: 0 17:04: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')]} 17:04:46 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456435168/firefox-45.0.en-US.linux-x86_64.tar.bz2 17:04:46 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456435168/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 17:04:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456435168/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 17:04:47 INFO - Downloaded 57948064 bytes. 17:04:47 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456435168/firefox-45.0.en-US.linux-x86_64.tar.bz2 17:04:47 INFO - mkdir: /builds/slave/test-pgo/properties 17:04:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 17:04:47 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 17:04:47 INFO - Contents: 17:04:47 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456435168/firefox-45.0.en-US.linux-x86_64.tar.bz2 17:04:47 INFO - Running post-action listener: _resource_record_post_action 17:04:47 INFO - Running post-action listener: set_extra_try_arguments 17:04:47 INFO - ##### 17:04:47 INFO - ##### Running populate-webroot step. 17:04:47 INFO - ##### 17:04:47 INFO - Running pre-action listener: _resource_record_pre_action 17:04:47 INFO - Running main action method: populate_webroot 17:04:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:04:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:04:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:04:47 INFO - '--tppagecycles', 17:04:47 INFO - '7'], 17:04:47 INFO - 'tests': ['tsvgm']}}, 17:04:47 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:04:47 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:04:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:04:47 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:04:47 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:04:47 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:04:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:04:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:04:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:04:47 INFO - 'talos_options': ['--e10s'], 17:04:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:04:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:04:47 INFO - 'tests': ['damp', 'tps']}, 17:04:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:04:47 INFO - 'talos_options': ['--e10s'], 17:04:47 INFO - 'tests': ['damp', 'tps']}, 17:04:47 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:04:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:04:47 INFO - 'other': {'tests': ['a11yr', 17:04:47 INFO - 'ts_paint', 17:04:47 INFO - 'tpaint', 17:04:47 INFO - 'sessionrestore', 17:04:47 INFO - 'sessionrestore_no_auto_restore']}, 17:04:47 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:04:47 INFO - 'tests': ['a11yr', 17:04:47 INFO - 'ts_paint', 17:04:47 INFO - 'tpaint', 17:04:47 INFO - 'sessionrestore', 17:04:47 INFO - 'sessionrestore_no_auto_restore']}, 17:04:47 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:04:47 INFO - 'tests': ['a11yr', 17:04:47 INFO - 'ts_paint', 17:04:47 INFO - 'tpaint', 17:04:47 INFO - 'sessionrestore', 17:04:47 INFO - 'sessionrestore_no_auto_restore']}, 17:04:47 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:04:47 INFO - 'tests': ['a11yr', 17:04:47 INFO - 'ts_paint', 17:04:47 INFO - 'tpaint', 17:04:47 INFO - 'sessionrestore', 17:04:47 INFO - 'sessionrestore_no_auto_restore']}, 17:04:47 INFO - 'other_l64': {'tests': ['a11yr', 17:04:47 INFO - 'ts_paint', 17:04:47 INFO - 'tpaint', 17:04:47 INFO - 'sessionrestore', 17:04:47 INFO - 'sessionrestore_no_auto_restore']}, 17:04:47 INFO - 'other_nol64': {'tests': ['a11yr', 17:04:47 INFO - 'ts_paint', 17:04:47 INFO - 'tpaint', 17:04:47 INFO - 'sessionrestore', 17:04:47 INFO - 'sessionrestore_no_auto_restore']}, 17:04:47 INFO - 'svgr': {'tests': ['tsvgx', 17:04:47 INFO - 'tsvgr_opacity', 17:04:47 INFO - 'tart', 17:04:47 INFO - 'tscrollx', 17:04:47 INFO - 'cart']}, 17:04:47 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:04:47 INFO - 'tests': ['tsvgx', 17:04:47 INFO - 'tsvgr_opacity', 17:04:47 INFO - 'tart', 17:04:47 INFO - 'tscrollx', 17:04:47 INFO - 'cart']}, 17:04:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:04:47 INFO - 'tests': ['tp5o']}, 17:04:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:04:47 INFO - 'talos_options': ['--e10s'], 17:04:47 INFO - 'tests': ['tp5o']}, 17:04:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:04:47 INFO - 'talos_options': ['--xperf_path', 17:04:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:04:47 INFO - 'tests': ['tp5n']}, 17:04:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:04:47 INFO - 'talos_options': ['--e10s', 17:04:47 INFO - '--xperf_path', 17:04:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:04:47 INFO - 'tests': ['tp5n']}}, 17:04:47 INFO - 'talos.zip': {'path': '', 17:04:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:04:47 INFO - Running post-action listener: _resource_record_post_action 17:04:47 INFO - ##### 17:04:47 INFO - ##### Running create-virtualenv step. 17:04:47 INFO - ##### 17:04:47 INFO - Running pre-action listener: _resource_record_pre_action 17:04:47 INFO - Running main action method: create_virtualenv 17:04:47 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 17:04:47 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 17:04:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 17:04:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:04:47 INFO - Using real prefix '/usr' 17:04:47 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 17:04:48 INFO - Installing distribute.............................................................................................................................................................................................done. 17:04:50 INFO - Installing pip.................done. 17:04:50 INFO - Return code: 0 17:04:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 17:04:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:50 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 0x7f5b07faaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe23600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb2350>, '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 0xeb3250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeb36e0>, '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': '1861a34ebfea852630dec091000001fa-1456447534.865157-1401355038', '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 17:04:50 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 17:04:50 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 17:04:50 INFO - Using env: {'DISPLAY': ':0', 17:04:50 INFO - 'HOME': '/home/cltbld', 17:04:50 INFO - 'LANG': 'en_US.UTF-8', 17:04:50 INFO - 'LANGUAGE': 'en_US:en', 17:04:50 INFO - 'LOGNAME': 'cltbld', 17:04:50 INFO - 'MAIL': '/var/mail/cltbld', 17:04:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:50 INFO - 'MOZ_NO_REMOTE': '1', 17:04:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:50 INFO - 'NO_EM_RESTART': '1', 17:04:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:04:50 INFO - 'PWD': '/builds/slave/test-pgo', 17:04:50 INFO - 'SHELL': '/bin/bash', 17:04:50 INFO - 'SHLVL': '1', 17:04:50 INFO - 'TERM': 'linux', 17:04:50 INFO - 'TMOUT': '86400', 17:04:50 INFO - 'USER': 'cltbld', 17:04:50 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1456447534.865157-1401355038', 17:04:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:50 INFO - '_': '/tools/buildbot/bin/python'} 17:04:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:50 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 17:04:50 INFO - Cleaning up... 17:04:50 INFO - Return code: 0 17:04:50 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 17:04:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:50 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 0x7f5b07faaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe23600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb2350>, '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 0xeb3250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeb36e0>, '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': '1861a34ebfea852630dec091000001fa-1456447534.865157-1401355038', '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 17:04:50 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 17:04:50 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 17:04:50 INFO - Using env: {'DISPLAY': ':0', 17:04:50 INFO - 'HOME': '/home/cltbld', 17:04:50 INFO - 'LANG': 'en_US.UTF-8', 17:04:50 INFO - 'LANGUAGE': 'en_US:en', 17:04:50 INFO - 'LOGNAME': 'cltbld', 17:04:50 INFO - 'MAIL': '/var/mail/cltbld', 17:04:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:50 INFO - 'MOZ_NO_REMOTE': '1', 17:04:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:50 INFO - 'NO_EM_RESTART': '1', 17:04:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:04:50 INFO - 'PWD': '/builds/slave/test-pgo', 17:04:50 INFO - 'SHELL': '/bin/bash', 17:04:50 INFO - 'SHLVL': '1', 17:04:50 INFO - 'TERM': 'linux', 17:04:50 INFO - 'TMOUT': '86400', 17:04:50 INFO - 'USER': 'cltbld', 17:04:50 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1456447534.865157-1401355038', 17:04:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:50 INFO - '_': '/tools/buildbot/bin/python'} 17:04:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:50 INFO - Downloading/unpacking psutil>=0.7.1 17:04:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 17:04:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:04:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:04:52 INFO - Installing collected packages: psutil 17:04:52 INFO - Running setup.py install for psutil 17:04:52 INFO - building 'psutil._psutil_linux' extension 17:04:52 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 17:04:53 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 17:04:53 INFO - building 'psutil._psutil_posix' extension 17:04:53 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 17:04:53 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 17:04:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:04:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:04:53 INFO - Successfully installed psutil 17:04:53 INFO - Cleaning up... 17:04:53 INFO - Return code: 0 17:04:53 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 17:04:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:53 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 0x7f5b07faaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe23600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb2350>, '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 0xeb3250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeb36e0>, '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': '1861a34ebfea852630dec091000001fa-1456447534.865157-1401355038', '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 17:04:53 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 17:04:53 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 17:04:53 INFO - Using env: {'DISPLAY': ':0', 17:04:53 INFO - 'HOME': '/home/cltbld', 17:04:53 INFO - 'LANG': 'en_US.UTF-8', 17:04:53 INFO - 'LANGUAGE': 'en_US:en', 17:04:53 INFO - 'LOGNAME': 'cltbld', 17:04:53 INFO - 'MAIL': '/var/mail/cltbld', 17:04:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:53 INFO - 'MOZ_NO_REMOTE': '1', 17:04:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:53 INFO - 'NO_EM_RESTART': '1', 17:04:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:04:53 INFO - 'PWD': '/builds/slave/test-pgo', 17:04:53 INFO - 'SHELL': '/bin/bash', 17:04:53 INFO - 'SHLVL': '1', 17:04:53 INFO - 'TERM': 'linux', 17:04:53 INFO - 'TMOUT': '86400', 17:04:53 INFO - 'USER': 'cltbld', 17:04:53 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1456447534.865157-1401355038', 17:04:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:53 INFO - '_': '/tools/buildbot/bin/python'} 17:04:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:04:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:55 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:04:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:04:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:04:55 INFO - Installing collected packages: mozsystemmonitor 17:04:55 INFO - Running setup.py install for mozsystemmonitor 17:04:55 INFO - Successfully installed mozsystemmonitor 17:04:55 INFO - Cleaning up... 17:04:55 INFO - Return code: 0 17:04:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 17:04: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')]} 17:04:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04: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')]} 17:04:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04: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', '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 0x7f5b07faaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe23600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb2350>, '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 0xeb3250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeb36e0>, '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': '1861a34ebfea852630dec091000001fa-1456447534.865157-1401355038', '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 17:04: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', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 17:04: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 blobuploader==1.2.4 17:04:55 INFO - Using env: {'DISPLAY': ':0', 17:04:55 INFO - 'HOME': '/home/cltbld', 17:04:55 INFO - 'LANG': 'en_US.UTF-8', 17:04:55 INFO - 'LANGUAGE': 'en_US:en', 17:04:55 INFO - 'LOGNAME': 'cltbld', 17:04:55 INFO - 'MAIL': '/var/mail/cltbld', 17:04:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:55 INFO - 'MOZ_NO_REMOTE': '1', 17:04:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:55 INFO - 'NO_EM_RESTART': '1', 17:04:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:04:55 INFO - 'PWD': '/builds/slave/test-pgo', 17:04:55 INFO - 'SHELL': '/bin/bash', 17:04:55 INFO - 'SHLVL': '1', 17:04:55 INFO - 'TERM': 'linux', 17:04:55 INFO - 'TMOUT': '86400', 17:04:55 INFO - 'USER': 'cltbld', 17:04:55 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1456447534.865157-1401355038', 17:04:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:55 INFO - '_': '/tools/buildbot/bin/python'} 17:04:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:55 INFO - Downloading/unpacking blobuploader==1.2.4 17:04: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 17:04: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 17:04: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 17:04: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 17:04: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 17:04: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 17:04:57 INFO - Downloading blobuploader-1.2.4.tar.gz 17:04:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:04:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:04: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 17:04: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 17:04: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 17:04: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 17:04: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 17:04: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 17:04:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 17:04:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:04:58 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 17:04:58 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 17:04:58 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 17:04:58 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 17:04:58 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 17:04:58 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 17:04:58 INFO - Downloading docopt-0.6.1.tar.gz 17:04:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 17:04:58 INFO - Installing collected packages: blobuploader, requests, docopt 17:04:58 INFO - Running setup.py install for blobuploader 17:04:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:04:58 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 17:04:58 INFO - Running setup.py install for requests 17:04:58 INFO - Running setup.py install for docopt 17:04:58 INFO - Successfully installed blobuploader requests docopt 17:04:58 INFO - Cleaning up... 17:04:58 INFO - Return code: 0 17:04:58 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:04:58 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')]} 17:04:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:58 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')]} 17:04:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:58 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 0x7f5b07faaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe23600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb2350>, '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 0xeb3250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeb36e0>, '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': '1861a34ebfea852630dec091000001fa-1456447534.865157-1401355038', '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 17:04:58 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 17:04:58 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 17:04:58 INFO - Using env: {'DISPLAY': ':0', 17:04:58 INFO - 'HOME': '/home/cltbld', 17:04:58 INFO - 'LANG': 'en_US.UTF-8', 17:04:58 INFO - 'LANGUAGE': 'en_US:en', 17:04:58 INFO - 'LOGNAME': 'cltbld', 17:04:58 INFO - 'MAIL': '/var/mail/cltbld', 17:04:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:58 INFO - 'MOZ_NO_REMOTE': '1', 17:04:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:58 INFO - 'NO_EM_RESTART': '1', 17:04:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:04:58 INFO - 'PWD': '/builds/slave/test-pgo', 17:04:58 INFO - 'SHELL': '/bin/bash', 17:04:58 INFO - 'SHLVL': '1', 17:04:58 INFO - 'TERM': 'linux', 17:04:58 INFO - 'TMOUT': '86400', 17:04:58 INFO - 'USER': 'cltbld', 17:04:58 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1456447534.865157-1401355038', 17:04:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:58 INFO - '_': '/tools/buildbot/bin/python'} 17:04:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:04:59 INFO - Running setup.py (path:/tmp/pip-Br7RnC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:04:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:04:59 INFO - Running setup.py (path:/tmp/pip-0WGI92-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:04:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:04:59 INFO - Running setup.py (path:/tmp/pip-ILwSHQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:04:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:04:59 INFO - Running setup.py (path:/tmp/pip-8mwNWa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:04:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 17:04:59 INFO - Running setup.py (path:/tmp/pip-TEIPxF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 17:04:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:04:59 INFO - Running setup.py (path:/tmp/pip-UKPyQq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:04:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:04:59 INFO - Running setup.py (path:/tmp/pip-fdEdqZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:04:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:04:59 INFO - Running setup.py (path:/tmp/pip-tZR995-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:04:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 17:04:59 INFO - Running setup.py (path:/tmp/pip-nfOHJq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 17:04:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 17:04:59 INFO - Running setup.py (path:/tmp/pip-Yzu0xA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 17:04:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:04:59 INFO - Running setup.py (path:/tmp/pip-gzFEX0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:04:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:04:59 INFO - Running setup.py (path:/tmp/pip-RGJfAP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:05:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:05:00 INFO - Running setup.py (path:/tmp/pip-VWI26E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:05:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:05:00 INFO - Running setup.py (path:/tmp/pip-DoxIKI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:05:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:05:00 INFO - Running setup.py (path:/tmp/pip-RBoWCC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:05:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 17:05:00 INFO - Running setup.py (path:/tmp/pip-s0Tf3F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 17:05:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 17:05:00 INFO - Running setup.py (path:/tmp/pip-bUZqd6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 17:05:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:05:00 INFO - Running setup.py install for manifestparser 17:05:00 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 17:05:00 INFO - Running setup.py install for mozcrash 17:05:00 INFO - Running setup.py install for mozdebug 17:05:00 INFO - Running setup.py install for mozdevice 17:05:00 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 17:05:00 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 17:05:00 INFO - Running setup.py install for mozfile 17:05:00 INFO - Running setup.py install for mozhttpd 17:05:01 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 17:05:01 INFO - Running setup.py install for mozinfo 17:05:01 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 17:05:01 INFO - Running setup.py install for mozInstall 17:05:01 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 17:05:01 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 17:05:01 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 17:05:01 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 17:05:01 INFO - Running setup.py install for mozleak 17:05:01 INFO - Running setup.py install for mozlog 17:05:01 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 17:05:01 INFO - Running setup.py install for moznetwork 17:05:01 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 17:05:01 INFO - Running setup.py install for mozprocess 17:05:01 INFO - Running setup.py install for mozprofile 17:05:01 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 17:05:01 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 17:05:01 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 17:05:01 INFO - Running setup.py install for mozrunner 17:05:01 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 17:05:01 INFO - Running setup.py install for mozscreenshot 17:05:01 INFO - Running setup.py install for moztest 17:05:02 INFO - Running setup.py install for mozversion 17:05:02 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 17:05:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:05:02 INFO - Cleaning up... 17:05:02 INFO - Return code: 0 17:05:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:05:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:05:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:05:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:05:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:05:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:05:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:05:02 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 0x7f5b07faaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe23600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb2350>, '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 0xeb3250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeb36e0>, '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': '1861a34ebfea852630dec091000001fa-1456447534.865157-1401355038', '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 17:05:02 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 17:05:02 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 17:05:02 INFO - Using env: {'DISPLAY': ':0', 17:05:02 INFO - 'HOME': '/home/cltbld', 17:05:02 INFO - 'LANG': 'en_US.UTF-8', 17:05:02 INFO - 'LANGUAGE': 'en_US:en', 17:05:02 INFO - 'LOGNAME': 'cltbld', 17:05:02 INFO - 'MAIL': '/var/mail/cltbld', 17:05:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:05:02 INFO - 'MOZ_NO_REMOTE': '1', 17:05:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:05:02 INFO - 'NO_EM_RESTART': '1', 17:05:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:05:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:05:02 INFO - 'PWD': '/builds/slave/test-pgo', 17:05:02 INFO - 'SHELL': '/bin/bash', 17:05:02 INFO - 'SHLVL': '1', 17:05:02 INFO - 'TERM': 'linux', 17:05:02 INFO - 'TMOUT': '86400', 17:05:02 INFO - 'USER': 'cltbld', 17:05:02 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1456447534.865157-1401355038', 17:05:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:05:02 INFO - '_': '/tools/buildbot/bin/python'} 17:05:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:05:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:05:02 INFO - Running setup.py (path:/tmp/pip-v9PrN6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:05:02 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)) 17:05:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:05:02 INFO - Running setup.py (path:/tmp/pip-rG4bhi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:05:02 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)) 17:05:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:05:02 INFO - Running setup.py (path:/tmp/pip-r_g8AL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:05:02 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)) 17:05:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:05:02 INFO - Running setup.py (path:/tmp/pip-VEJhoe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:05:02 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)) 17:05:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 17:05:02 INFO - Running setup.py (path:/tmp/pip-ttjSj1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 17:05:02 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)) 17:05:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:05:02 INFO - Running setup.py (path:/tmp/pip-6yhw_d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:05:02 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)) 17:05:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:05:02 INFO - Running setup.py (path:/tmp/pip-Za6ib3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:05:02 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)) 17:05:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:05:02 INFO - Running setup.py (path:/tmp/pip-eQ8Oxd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:05:02 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)) 17:05:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 17:05:02 INFO - Running setup.py (path:/tmp/pip-y4KX5N-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 17:05:03 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)) 17:05:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 17:05:03 INFO - Running setup.py (path:/tmp/pip-S67HeR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 17:05:03 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)) 17:05:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:05:03 INFO - Running setup.py (path:/tmp/pip-fmssla-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:05:03 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)) 17:05:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:05:03 INFO - Running setup.py (path:/tmp/pip-OKF6Tc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:05:03 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)) 17:05:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:05:03 INFO - Running setup.py (path:/tmp/pip-qwun1c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:05:03 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)) 17:05:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:05:03 INFO - Running setup.py (path:/tmp/pip-jFLn7P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:05:03 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)) 17:05:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:05:03 INFO - Running setup.py (path:/tmp/pip-g4AhPM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:05:03 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)) 17:05:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 17:05:03 INFO - Running setup.py (path:/tmp/pip-USLqxu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 17:05:03 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)) 17:05:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 17:05:03 INFO - Running setup.py (path:/tmp/pip-sN1OMw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 17:05:03 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)) 17:05:03 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)) 17:05:03 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)) 17:05:03 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)) 17:05:03 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)) 17:05:03 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)) 17:05:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 17:05:03 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 17:05:03 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 17:05:03 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 17:05:03 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 17:05:03 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 17:05:03 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 17:05:05 INFO - Downloading blessings-1.6.tar.gz 17:05:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 17:05:05 INFO - Installing collected packages: blessings 17:05:05 INFO - Running setup.py install for blessings 17:05:05 INFO - Successfully installed blessings 17:05:05 INFO - Cleaning up... 17:05:05 INFO - Return code: 0 17:05:05 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 17:05:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 17:05:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 17:05:05 INFO - Reading from file tmpfile_stdout 17:05:05 INFO - Current package versions: 17:05:05 INFO - argparse == 1.2.1 17:05:05 INFO - blessings == 1.6 17:05:05 INFO - blobuploader == 1.2.4 17:05:05 INFO - docopt == 0.6.1 17:05:05 INFO - manifestparser == 1.1 17:05:05 INFO - mozInstall == 1.12 17:05:05 INFO - mozcrash == 0.16 17:05:05 INFO - mozdebug == 0.1 17:05:05 INFO - mozdevice == 0.47 17:05:05 INFO - mozfile == 1.2 17:05:05 INFO - mozhttpd == 0.7 17:05:05 INFO - mozinfo == 0.9 17:05:05 INFO - mozleak == 0.1 17:05:05 INFO - mozlog == 3.1 17:05:05 INFO - moznetwork == 0.27 17:05:05 INFO - mozprocess == 0.22 17:05:05 INFO - mozprofile == 0.27 17:05:05 INFO - mozrunner == 6.11 17:05:05 INFO - mozscreenshot == 0.1 17:05:05 INFO - mozsystemmonitor == 0.0 17:05:05 INFO - moztest == 0.7 17:05:05 INFO - mozversion == 1.4 17:05:05 INFO - psutil == 3.1.1 17:05:05 INFO - requests == 1.2.3 17:05:05 INFO - wsgiref == 0.1.2 17:05:05 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:05:05 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')]} 17:05:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:05:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:05:05 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')]} 17:05:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:05:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:05:05 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 0x7f5b07faaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe23600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb2350>, '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 0xeb3250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeb36e0>, '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': '1861a34ebfea852630dec091000001fa-1456447534.865157-1401355038', '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 17:05:05 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 17:05:05 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 17:05:05 INFO - Using env: {'DISPLAY': ':0', 17:05:05 INFO - 'HOME': '/home/cltbld', 17:05:05 INFO - 'LANG': 'en_US.UTF-8', 17:05:05 INFO - 'LANGUAGE': 'en_US:en', 17:05:05 INFO - 'LOGNAME': 'cltbld', 17:05:05 INFO - 'MAIL': '/var/mail/cltbld', 17:05:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:05:05 INFO - 'MOZ_NO_REMOTE': '1', 17:05:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:05:05 INFO - 'NO_EM_RESTART': '1', 17:05:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:05:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:05:05 INFO - 'PWD': '/builds/slave/test-pgo', 17:05:05 INFO - 'SHELL': '/bin/bash', 17:05:05 INFO - 'SHLVL': '1', 17:05:05 INFO - 'TERM': 'linux', 17:05:05 INFO - 'TMOUT': '86400', 17:05:05 INFO - 'USER': 'cltbld', 17:05:05 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1456447534.865157-1401355038', 17:05:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:05:05 INFO - '_': '/tools/buildbot/bin/python'} 17:05:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:05:06 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)) 17:05:06 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)) 17:05:06 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)) 17:05:06 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)) 17:05:06 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)) 17:05:06 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)) 17:05:06 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)) 17:05:06 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)) 17:05:06 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)) 17:05:06 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)) 17:05:06 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)) 17:05:06 INFO - Cleaning up... 17:05:06 INFO - Return code: 0 17:05:06 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 17:05:06 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')]} 17:05:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:05:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:05:06 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')]} 17:05:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:05:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:05:06 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 0x7f5b07faaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe23600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb2350>, '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 0xeb3250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeb36e0>, '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': '1861a34ebfea852630dec091000001fa-1456447534.865157-1401355038', '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 17:05:06 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 17:05:06 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 17:05:06 INFO - Using env: {'DISPLAY': ':0', 17:05:06 INFO - 'HOME': '/home/cltbld', 17:05:06 INFO - 'LANG': 'en_US.UTF-8', 17:05:06 INFO - 'LANGUAGE': 'en_US:en', 17:05:06 INFO - 'LOGNAME': 'cltbld', 17:05:06 INFO - 'MAIL': '/var/mail/cltbld', 17:05:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:05:06 INFO - 'MOZ_NO_REMOTE': '1', 17:05:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:05:06 INFO - 'NO_EM_RESTART': '1', 17:05:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:05:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:05:06 INFO - 'PWD': '/builds/slave/test-pgo', 17:05:06 INFO - 'SHELL': '/bin/bash', 17:05:06 INFO - 'SHLVL': '1', 17:05:06 INFO - 'TERM': 'linux', 17:05:06 INFO - 'TMOUT': '86400', 17:05:06 INFO - 'USER': 'cltbld', 17:05:06 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1456447534.865157-1401355038', 17:05:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:05:06 INFO - '_': '/tools/buildbot/bin/python'} 17:05:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:05:06 INFO - Downloading/unpacking jsonschema 17:05:06 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 17:05:06 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 17:05:06 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 17:05:06 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 17:05:06 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 17:05:06 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 17:05:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:05:08 INFO - Downloading/unpacking functools32 (from jsonschema) 17:05:08 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 17:05:08 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 17:05:08 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 17:05:08 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 17:05:08 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 17:05:08 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 17:05:08 INFO - Downloading functools32-3.2.3-2.tar.gz 17:05:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 17:05:08 INFO - warning: no files found matching '*.txt' 17:05:08 INFO - no previously-included directories found matching 'build' 17:05:08 INFO - no previously-included directories found matching 'dist' 17:05:08 INFO - no previously-included directories found matching '.git*' 17:05:08 INFO - Installing collected packages: jsonschema, functools32 17:05:08 INFO - Running setup.py install for functools32 17:05:08 INFO - warning: no files found matching '*.txt' 17:05:08 INFO - no previously-included directories found matching 'build' 17:05:08 INFO - no previously-included directories found matching 'dist' 17:05:08 INFO - no previously-included directories found matching '.git*' 17:05:08 INFO - Successfully installed jsonschema functools32 17:05:08 INFO - Cleaning up... 17:05:08 INFO - Return code: 0 17:05:08 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 17:05:08 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')]} 17:05:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:05:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:05:08 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')]} 17:05:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:05:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:05:08 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 0x7f5b07faaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe23600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb2350>, '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 0xeb3250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeb36e0>, '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': '1861a34ebfea852630dec091000001fa-1456447534.865157-1401355038', '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 17:05:08 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 17:05:08 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 17:05:08 INFO - Using env: {'DISPLAY': ':0', 17:05:08 INFO - 'HOME': '/home/cltbld', 17:05:08 INFO - 'LANG': 'en_US.UTF-8', 17:05:08 INFO - 'LANGUAGE': 'en_US:en', 17:05:08 INFO - 'LOGNAME': 'cltbld', 17:05:08 INFO - 'MAIL': '/var/mail/cltbld', 17:05:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:05:08 INFO - 'MOZ_NO_REMOTE': '1', 17:05:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:05:08 INFO - 'NO_EM_RESTART': '1', 17:05:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:05:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:05:08 INFO - 'PWD': '/builds/slave/test-pgo', 17:05:08 INFO - 'SHELL': '/bin/bash', 17:05:08 INFO - 'SHLVL': '1', 17:05:08 INFO - 'TERM': 'linux', 17:05:08 INFO - 'TMOUT': '86400', 17:05:08 INFO - 'USER': 'cltbld', 17:05:08 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1456447534.865157-1401355038', 17:05:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:05:08 INFO - '_': '/tools/buildbot/bin/python'} 17:05:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:05:08 INFO - Downloading/unpacking flake8 17:05:08 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 17:05:08 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 17:05:08 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 17:05:08 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 17:05:08 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 17:05:08 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 17:05:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:05:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:05: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 17:05: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 17:05: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 17:05: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 17:05: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 17:05: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 17:05:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:05:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:05: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 17:05: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 17:05: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 17:05: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 17:05: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 17:05: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 17:05:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:05:11 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 17:05:11 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 17:05:11 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 17:05:11 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 17:05:11 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 17:05:11 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 17:05:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 17:05:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:05:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:05:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:05:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:05:11 INFO - no previously-included directories found matching 'docs/_build' 17:05:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:05:11 INFO - Running setup.py install for pep8 17:05:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:05:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:05:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:05:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:05:11 INFO - no previously-included directories found matching 'docs/_build' 17:05:11 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 17:05:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:05:11 INFO - Cleaning up... 17:05:11 INFO - Return code: 0 17:05:11 INFO - Running post-action listener: _resource_record_post_action 17:05:11 INFO - Running post-action listener: _start_resource_monitoring 17:05:11 INFO - Starting resource monitoring. 17:05:11 INFO - ##### 17:05:11 INFO - ##### Running install step. 17:05:11 INFO - ##### 17:05:11 INFO - Running pre-action listener: _resource_record_pre_action 17:05:11 INFO - Running main action method: install 17:05:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 17:05:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 17:05:11 INFO - Reading from file tmpfile_stdout 17:05:11 INFO - Detecting whether we're running mozinstall >=1.0... 17:05:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 17:05:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 17:05:12 INFO - Reading from file tmpfile_stdout 17:05:12 INFO - Output received: 17:05:12 INFO - Usage: mozinstall [options] installer 17:05:12 INFO - Options: 17:05:12 INFO - -h, --help show this help message and exit 17:05:12 INFO - -d DEST, --destination=DEST 17:05:12 INFO - Directory to install application into. [default: 17:05:12 INFO - "/builds/slave/test-pgo"] 17:05:12 INFO - --app=APP Application being installed. [default: firefox] 17:05:12 INFO - mkdir: /builds/slave/test-pgo/build/application 17:05:12 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'] 17:05:12 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 17:05:27 INFO - Reading from file tmpfile_stdout 17:05:27 INFO - Output received: 17:05:27 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 17:05:27 INFO - Running post-action listener: _resource_record_post_action 17:05:27 INFO - ##### 17:05:27 INFO - ##### Running run-tests step. 17:05:27 INFO - ##### 17:05:27 INFO - Running pre-action listener: _resource_record_pre_action 17:05:27 INFO - Running main action method: run_tests 17:05:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 17:05:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 17:05:27 INFO - Python 2.7.3 17:05:27 INFO - Return code: 0 17:05:27 INFO - grabbing minidump binary from tooltool 17:05: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')]} 17:05: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 0xeb2350>, '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 0xeb3250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeb36e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 17:05: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 17:05: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 17:05:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:05:27 INFO - Return code: 0 17:05:27 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 17:05:27 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 17:05:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 17:05:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 17:05:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 17:05:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 17:05:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 17:05:28 INFO - Return code: 0 17:05:28 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/1456435168/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 17:05:28 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/1456435168/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-069 --webServer localhost 17:05:28 INFO - Using env: {'DISPLAY': ':0', 17:05:28 INFO - 'HOME': '/home/cltbld', 17:05:28 INFO - 'LANG': 'en_US.UTF-8', 17:05:28 INFO - 'LANGUAGE': 'en_US:en', 17:05:28 INFO - 'LOGNAME': 'cltbld', 17:05:28 INFO - 'MAIL': '/var/mail/cltbld', 17:05:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 17:05:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 17:05:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:05:28 INFO - 'MOZ_NO_REMOTE': '1', 17:05:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 17:05:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:05:28 INFO - 'NO_EM_RESTART': '1', 17:05:28 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:05:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:05:28 INFO - 'PWD': '/builds/slave/test-pgo', 17:05:28 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 17:05:28 INFO - 'SHELL': '/bin/bash', 17:05:28 INFO - 'SHLVL': '1', 17:05:28 INFO - 'TERM': 'linux', 17:05:28 INFO - 'TMOUT': '86400', 17:05:28 INFO - 'USER': 'cltbld', 17:05:28 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1456447534.865157-1401355038', 17:05:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:05:28 INFO - '_': '/tools/buildbot/bin/python'} 17:05:28 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/1456435168/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--webServer', 'localhost'] with output_timeout 3600 17:05:28 INFO - mozversion INFO | application_buildid: 20160225131928 17:05:28 INFO - mozversion INFO | application_changeset: 86b07e82b7411e80e2b8e51f5a2ef613f727950e 17:05:28 INFO - mozversion INFO | application_display_name: Nightly 17:05:28 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:05:28 INFO - mozversion INFO | application_name: Firefox 17:05:28 INFO - mozversion INFO | application_remotingname: firefox 17:05:28 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-beta 17:05:28 INFO - mozversion INFO | application_vendor: Mozilla 17:05:28 INFO - mozversion INFO | application_version: 45.0 17:05:28 INFO - mozversion INFO | platform_buildid: 20160225131928 17:05:28 INFO - mozversion INFO | platform_changeset: 86b07e82b7411e80e2b8e51f5a2ef613f727950e 17:05:28 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-beta 17:05:28 INFO - mozversion INFO | platform_version: 45.0 17:05:28 INFO - 2016-02-25 17:05:28,467 DEBUG : using testdate: 1456448728 17:05:28 INFO - 2016-02-25 17:05:28,467 DEBUG : actual date: 1456448728 17:05:28 INFO - 2016-02-25 17:05:28,542 INFO : starting webserver on 'localhost:32792' 17:05:28 INFO - 2016-02-25 17:05:28,543 INFO : Starting test suite talos-linux64-ix-069 17:05:28 INFO - 2016-02-25 17:05:28,543 INFO : Starting test dromaeo_css 17:05:28 INFO - 2016-02-25 17:05:28,543 DEBUG : operating with platform_type : linux_ 17:05:28 INFO - 2016-02-25 17:05:28,544 INFO : Initialising browser for dromaeo_css test... 17:05:28 INFO - 2016-02-25 17:05:28,556 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9qMlNR/profile http://localhost:32792/getInfo.html 17:05:33 INFO - 2016-02-25 17:05:33,543 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 17:05:33 INFO - 2016-02-25 17:05:33,544 DEBUG : BROWSER_OUTPUT: colorDepth:24 17:05:33 INFO - 2016-02-25 17:05:33,544 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 17:05:33 INFO - 2016-02-25 17:05:33,544 DEBUG : BROWSER_OUTPUT: __metrics 17:05:33 INFO - 2016-02-25 17:05:33,713 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] 17:05:34 INFO - 2016-02-25 17:05:34,597 INFO : Browser initialized. 17:05:34 INFO - 2016-02-25 17:05:34,598 INFO : Running cycle 1/1 for dromaeo_css test... 17:05:34 INFO - 2016-02-25 17:05:34,598 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9qMlNR/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 17:05:46 INFO - 2016-02-25 17:05:46,229 DEBUG : BROWSER_OUTPUT: RSS: Main: 134524928 17:05:46 INFO - 2016-02-25 17:05:46,229 DEBUG : BROWSER_OUTPUT: 17:06:36 INFO - 2016-02-25 17:06:36,973 DEBUG : BROWSER_OUTPUT: 1456448796970 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] 17:08:45 INFO - 2016-02-25 17:08:45,428 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32792/tests/dromaeo/cssquery-dojo.html (next: http://localhost:32792/tests/dromaeo/cssquery-ext.html) 17:08:46 INFO - 2016-02-25 17:08:46,400 DEBUG : BROWSER_OUTPUT: RSS: Main: 225521664 17:08:46 INFO - 2016-02-25 17:08:46,400 DEBUG : BROWSER_OUTPUT: 17:11:48 INFO - 2016-02-25 17:11:48,457 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32792/tests/dromaeo/cssquery-ext.html (next: http://localhost:32792/tests/dromaeo/cssquery-jquery.html) 17:11:49 INFO - 2016-02-25 17:11:49,023 DEBUG : BROWSER_OUTPUT: RSS: Main: 213254144 17:11:49 INFO - 2016-02-25 17:11:49,023 DEBUG : BROWSER_OUTPUT: 17:14:50 INFO - 2016-02-25 17:14:50,754 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32792/tests/dromaeo/cssquery-jquery.html (next: http://localhost:32792/tests/dromaeo/cssquery-mootools.html) 17:14:51 INFO - 2016-02-25 17:14:51,320 DEBUG : BROWSER_OUTPUT: RSS: Main: 210272256 17:14:51 INFO - 2016-02-25 17:14:51,320 DEBUG : BROWSER_OUTPUT: 17:17:53 INFO - 2016-02-25 17:17:53,005 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32792/tests/dromaeo/cssquery-mootools.html (next: http://localhost:32792/tests/dromaeo/cssquery-prototype.html) 17:17:53 INFO - 2016-02-25 17:17:53,567 DEBUG : BROWSER_OUTPUT: RSS: Main: 195489792 17:17:53 INFO - 2016-02-25 17:17:53,568 DEBUG : BROWSER_OUTPUT: 17:20:55 INFO - 2016-02-25 17:20:55,935 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32792/tests/dromaeo/cssquery-prototype.html (next: http://localhost:32792/tests/dromaeo/cssquery-yui.html) 17:20:56 INFO - 2016-02-25 17:20:56,522 DEBUG : BROWSER_OUTPUT: RSS: Main: 200552448 17:20:56 INFO - 2016-02-25 17:20:56,522 DEBUG : BROWSER_OUTPUT: 17:23:58 INFO - 2016-02-25 17:23:58,503 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32792/tests/dromaeo/cssquery-yui.html (next: http://localhost:32792/tests/dromaeo/cssquery-dojo.html) 17:23:58 INFO - 2016-02-25 17:23:58,749 DEBUG : BROWSER_OUTPUT: RSS: Main: 240521216 17:23:58 INFO - 2016-02-25 17:23:58,749 DEBUG : BROWSER_OUTPUT: 17:23:58 INFO - 2016-02-25 17:23:58,750 DEBUG : BROWSER_OUTPUT: __start_tp_report 17:23:58 INFO - 2016-02-25 17:23:58,750 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 17:23:58 INFO - 2016-02-25 17:23:58,751 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 17:23:58 INFO - 2016-02-25 17:23:58,751 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 17:23:58 INFO - 2016-02-25 17:23:58,752 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3220.066180807565;3304.1739565108724;3327.8169700666467;3329.0179397077845;3359.7480188985833;5333.973330133349;5439.619226654131;5445.428230035848;5478.643888147278;5490.286262785842;5431.21247419124;5464.0711079116545;5475.67145971242;5477.370102438221;5504.532114770239;4822.4213094428715;4970.999999999991;5056.84829455117;5082.720450375228;5120.718360490171;4903.436104847952;4959.404871415435;5027.09512287788;5031.371078615173;5031.597472202233;4992.975035124819;5023.748812559375;5061.974690126544;5081.441041485434;5088.771005304751;5067.873303167414;5116.948830511685;5122.538971492546;5134.820281290155;5161.148410512298;4825.517448255181;4856.344393506866;5038.042771873333;5047.520485553867;5101.056304583627;5145.691258524501;5234.26720259164;5245.134552798783;5246.554042906358;5256.816011439581;5865.76536938522;5885.352611212763;5933.22868027158;5933.703314834241;5934.347221805598;5636.098224284095;5768.682722450264;5838.065909454467;5949.940500595025;5962.97018514909;5563.610547261694;5612.579056570733;5615.185798059259;5616.297962754615;5616.466435688603;6058.27300723916;6062.545309101835;6068.393160683896;6068.423499767515;6074.726637301332;5618.157276408571;5731.398203188689;5781.4507621775865;5901.439363260569;5902.822915312548;5967.791127310524;5970.522358211333;5970.641761494324;5972.104184372379;6007.15899774032;5870.0607902735355;5921.911171332434;5925.4370834770625;5934.673592952429;5937.346891841894;5658.292713410824;5724.942750572524;5865.4134586541;5938.435848594377;5949.464548190684;4484.304932735366;4497.460304763384;4521.773911304422;4524.411826462539;4547.295169248771;4080.9183816323507;4082.1223436961195;4085;4086.244044851712;4113.382992551082;5396.622236443412;5493.752781124859;5521.1442226454965;5623.887522249532;5653.095504719307;5873.089671100986;5894.823155305347;5910.704464776744;5913.852153696192;5919.3192782829665;5574.916376254359;5604.523615492647;5612.130119831432;5612.635178713371;5612.7754889803955;4921.803127874917;5017.523335283142;5032.194848824171;5107.565856902131;5146.228065790161;6085.817425477243;6091.939080609137;6094.8171554853425;6102.023676211874;6102.420270074336;5653.406392328746;5912.940870591239;5919.852003699856;5930.169776231417;5930.7627694893445;5911.1428842816695;5987.760489580368;6091.116788065794;6093.451589356979;6126.326104128453;5743.4256574342235;5782.537397008314;5795.043817770189;5805.76776928935;5810.215620891126;5682.488576028178;5802.912956305574;5876.911846322223;5883.411658834082;5898.233229680286;5656.406077361818;5736.4550367715;5739.139129130664;5739.598228123991;5778.393268706725;5740.425957404226;5778.971105144447;5780.075187969905;5782.045962416154;5787.045137552425;5402.972985135049;5525.0883604204855;5545.279113715191;5673.035583950821;5692.117721753135;5714.942850571441;5734.541236701138;5744.396838331915;5746.367899530965;5783.219265399117;5633.915491267552;5663;5667.4615911488345;5671.234383358359;5672.404397538199 17:23:58 INFO - 2016-02-25 17:23:58,753 DEBUG : BROWSER_OUTPUT: |1;ext.html;549.4718856787823;586.9354371019188;593.1429084972216;593.6200831467864;603.9879202415949;31343;41935;42408.363874541865;42429.15141697172;42521.149577008444;46361.53638463614;47180.52819471804;47196.2920556192;47246.291305630446;47271;7710.383169346467;7826;8939.642414303436;9205.953970230139;9237.445753254826;10722.303050301745;10934.890651093507;10936;10949.069329107035;10949.397783121925;10793.946030269877;10926.235163538555;10928.508217130247;10932.781344373108;10941;7932.444728868982;8134.227248411392;10688.786224275509;10776.40729759863;11060.17048721349;10624.09695175911;10708.25042247043;10711.089557387631;10732.248742588023;10774.622888198954;42841;43335.13329733388;43350.132997340195;43382.56617433817;43392.56607433917;3331.916702082443;3384.1877949291993;3484.3205574912904;3847.2882516734494;4156.293430116887;32279.6772032279;32500;32527.674723252938;32689.182770430692;32704.182395440068;4222;4352.281873490871;4388.451443569554;4397.120575884804;4404.229259879508;306177;306603;307322;307854;309552.45223773964;64284.35715642784;64679;64709;64764.676176618814;64834;57099.145042747696;58303.4169658298;67727.66136169288;68226;68791.3120868795;16799.2440340185;17011.06439145834;17019.574510637085;17073.317067317417;17082.145892705314;13079.215247085014;13156.60530184096;13163.144395614254;13163.868361316456;13169.078164528391;20627.484312891997;20725.89637051805;20990.580188396147;21030.47423814417;21032;7805.180456052033;7942.324902383247;7963.1638677939145;8015;8066.475679080841;943.9056094390506;1025.8153532364247;1083.285031878956;1100.4772732951944;1101.2731597145846;29535.85232073826;29584.852075739484;29998.550021749692;30519.389612207633;30972;1105.38098664748;1113.3264375053138;1197.934113623759;1203.9458224379923;1283.3454937981696;13360.532381366605;15554.22228888551;15963.680726385408;16059.357625694842;16112.355505779638;409216;412768;413190;414953;417048;48235.75882120637;62000.37999620036;62780.68609657014;62782.372176278564;62936;1340.3968214303602;1400.2998500749625;1490.5304828978838;1491.963085655459;1500.534834201401;31711.682883171798;31798.364032719677;31956.20109497281;32471.837640811646;32712.83643581862;46972.7651361741;47491.52508474871;47516.52483475121;47556.7622161887;47704.76147619379;220956;221799;223910;228393;245008;34994.82502587471;36052.819735901154;36176;36229.818850905576;36405.08987275339;46300.07399851917;46869.53130468652;47310;47833.52166478291;48097.5190248107;39443.211135777696;39872.80063599663;40527.143629768645;41056;41152.794236028625;40079.39880901847;40307;40679.38980915348;40909.79545102375;41108;39231.6076839228;39562.80218598888;39762.801185993885;39766.60233397629;39789;34599.481007785405;35493;35607.287854242255;36017.63982360143;36073.81963090168;26535.867320663274;27134.864325678245;27382.315442114108;27390.178294651192;27418.862905685342 17:23:58 INFO - 2016-02-25 17:23:58,755 DEBUG : BROWSER_OUTPUT: |2;jquery.html;371.4407730735235;374.18801201392984;374.77700768043013;375.57184809317386;377.3905143193743;17329.046902420378;18272.634547309062;18427.75984956931;18566.90716546419;19779;18121.63756724868;18424.447266582025;18607.906960465214;18720.344787932427;18774.436766897015;4206.705530612859;4315.913681726363;5000.174971129768;5607.383187849333;5609.523190528789;4277.101808620194;5923.200367950315;6169.475594574466;6185.103160041791;6190.566660333779;5996.730147143389;6087.117367981662;6178.9691051544905;6184.56708030438;6185.041318595625;4203.180379825951;4309.547497512747;5970.552208584373;6075.817725468243;6090.086487026959;5443.618946673734;5447.618666693333;5461.781528738846;5461.9453805462235;5468.343798744176;20682.79317206839;21953.451163721034;22461.77538224613;22473.55052898933;22611.77388226113;2413.505231427553;2415.130553000918;2481.937951551208;2513.924582262535;2671.559192733216;14358;14421.134731916118;14446.783298250535;14769.33537990793;14824.258787060711;1981.28673677476;1990.0646696052977;2007.7389939307795;2047.764507081675;2051.917923283067;63982.360176398106;65065;65647.67176164089;66828.3317166827;67451.325486745;10507;10687.572497100029;10740.248182627141;10800.51397687106;10888.183386246063;14189.929050354682;14242.07426517273;14253.144811311355;14271.429142834379;14286.142831430148;8302.958485207535;8398.412111152284;8588.098249683693;8622.827543449095;8638.654453821777;8537.530435825965;8552.657893684307;8566.571671416405;8627.525486098199;8628.137186281321;6385.680715964276;6466;6468.5472016958365;6483.2544257411;6483.870322593521;1738.8608911287067;1785.366195000782;1812.5196822841958;1839.2275244397385;1869.205587625281;942.9717108486757;974.7368210583103;1016.6848277034143;1022.7187523431116;1044.7335929337971;16882.240299186567;17076.914615426842;17199.312027518758;17334.219960101826;17690.292388304322;876.4741155306892;970.3013830042358;982.597135174575;989.0455710239653;1029.953652085658;9384.390014649163;9930.801383972424;10261.7434564135;10293.74265643365;10364.170866330825;626209;633769;637241;653177;654606;84606;86493.56753216193;87275.56362218148;87605.56197218974;88703.11296887077;1245.1470742541387;1246.3456685240321;1249.8187762774346;1251.9874801252054;1265.3926115464628;15115.697686046438;15676.529704108894;15865.68268634644;16275.593110171867;16369.67260654804;32810.50784238191;32932.50601241031;32998;33522.497162542095;34120.1469963243;38747.80626096964;40322.79838600788;40741.38887916625;41666;44664.33003505015;9705.932347441634;9762.658306959222;9911.702648920544;9919.801603968024;9929.056739609725;18110.63778724392;18432.631347373244;18519.166637501614;18770;18997.525061873563;14921.701565968402;15460.226988650747;15726;15736;15975.360985560912;15105.54683359501;15113;15184.924075379553;15680;15846.762298565762;15411.306491207699;15725.213739313218;15755.684886302439;15934;16262.837371626132;9516.95241523788;9677.612895484102;9696.466694331879;9790.26573007013;9850.310478266452;10133.341332813343;12114.515419383126;15130.773038404213;15451.61370965735;15526.611834704223 17:23:58 INFO - 2016-02-25 17:23:58,756 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1554.2228885557222;1555.9377624894998;1751.632157246978;1775.3076300242903;1830.8993005384698;7883.448158628898;8280.62737176827;8288.502689838613;8292.419530632858;8294.875576866345;8034.758957231278;8108.148644392328;8129.512229266248;8135.75592732219;8137.18628137186;2232.10715713715;2235.2176738141684;2268.6710426988075;2271.205078222625;2271.5570463759573;2303.424143964009;2334.1830359374167;2335;2335.6730057791838;2337.520808234308;1914.473519782057;1956.8630195886294;1957.0997341223053;2216.556688662266;2303.665968434576;2200.449887528118;2255.3008567344095;2256.1088370093885;2258.1193334599357;2258.2660635293596;2263.388885001057;2264.4338915271182;2294.357579877637;2296.01271453275;2325.686032385623;6683.331666833278;6902.102726645504;7743.264389882952;8092.028956525196;8193;4719.9292010619865;4815.036992601459;4815.831445899412;4851.223804191348;4855.927161092586;2980.1059682095283;3003.9249018774485;3036.3927214556957;3040.5743195952364;3059.2351912021995;933.9626414943394;936.180841763457;946.5361972633428;967.4485543240356;979.0405402705388;11042.282251653616;11078.058365038982;11102.444877756161;11106.500207490602;11109.277896936754;4179.728317659403;4183.205191013698;4241.936370954438;4242.469691288589;4251.383549385322;9638.325317227867;9649.421034737938;9659.758506037406;9670.516474176404;9685.854712179182;4639.605633521121;4669.696469729457;4676.111538807616;4677.672562920563;4682.9765851171205;4203.096334288142;4204.516480604709;4206.074663574009;4210.263203939298;4210.494740631144;3509.7192224621967;3576.8390422431053;3597.7481576289933;3598.3163198992106;3599.154198763341;1021.4024795494719;1042.4996001919121;1045.095991966943;1061.580675633136;1065.4672663668166;1393.644620621735;1414.70291238841;1450.2386247220084;1459.737247295497;1465.8314293856342;7559.773206803805;7583.431242656823;7611.543307401574;7650.1202361728;7652.80867978305;447.84363290754914;453.36302494994584;454.79988804926387;456.5252137776675;456.99314510282375;5193.532582067632;5856.033754430471;5896.793612223637;5907.734151963172;5907.966105931445;8682.262007729414;9322;9498.050194980586;9573.32986690925;9589.136977672042;9325.393849399767;9389.577469013911;9441.952790236142;9476.431414115175;9723.124918757205;7661.463697541119;7668.463207575416;7679.1936846631415;7696.807579810549;7738.110117336466;7390.076240469942;7408.518446300973;7468.701251949861;7484.925150748423;7522.398208143445;8561.957190214009;8641.222289993932;8739.868901966604;8769.166929141722;8815.867761983447;8913.509756963429;8922.73231803047;9013.954930225307;9040.819183616422;9042.140996605312;7191.604461754654;7296.635168241461;7394.075740532434;7403.7408690695565;7407.074115735533;7812.453128280966;7917.327027202752;7952.244536768998;7966.322862556747;7974.40191985615;7402.259774022555;7431.554106753612;7489.325960663567;7494.325510704063;7511.136219334628;7381.889271660822;7395.482316237812;7401.0748656417945;7479.588622625808;7481.551106933602;7143.2499587544635;7150.177729561167;7197.100362454693;7217;7291.635418229173;6636.0377745225705;6645.169353830771;6648.867022659423;6661.467082633475;6664.200295964515;6698.162729658793;6725.29384414649;6812.829679258059;6815.69329380189;6835.658217089026 17:23:58 INFO - 2016-02-25 17:23:58,757 DEBUG : BROWSER_OUTPUT: |4;prototype.html;345.72514850693693;346.9514268002479;348.1574589493426;348.9546358973334;356.71641045368926;6072.058830881209;6113.602615829968;6140.631562106266;6148.231471066117;6218.689065546727;6052.364501727321;6065.514758819295;6066.120412540179;6073.119397687333;6079.7264123114455;4642.419697537808;4655.4878963314;4703.670743047996;4721.433427988646;4723.622110231173;4712.787924543387;4725.480197178307;4726.527347265281;4727.952720472786;4734.881627959294;4675.672702910781;4677.041206552649;4678;4689.179393606105;4689.5310468953;4481.551844815509;4550.863474095782;4579.152856721484;4686.695364801294;4720.716756994557;4144.316187829005;4161.97919010403;4173.436586060873;4180.352045432963;4183.079722461053;5661.179129026309;5847.590668653196;5857.384974577651;5859.2382990211;5862.853428664275;5357.7589008494715;5392.379876314196;5516.972415137939;5520.282363292747;5521.861953451155;6425.8393540161405;6445.806625801233;6451.870962580769;6459.192600924885;6459.870802583969;4622.838200662961;4624.144533261324;4626.653001024903;4629.606483448911;4629.861104166846;6629.502787290972;6702.798916032527;6718;6725.226598941135;6729.966350168267;4744.430668319824;4755.500672429345;4758.191107511731;4759.048190361872;4763.928541071887;4776.379070720854;4784.617230621542;4787.234042553245;4789.688670236424;4793.904121917542;5269.657472264291;5478.616496845262;5483.616146869761;5492.176173573996;5495.450454954473;6556.114924485133;6564.113844631009;6564.277929427759;6573.901391479131;6576;1632.9755053674205;1644.3587001069354;1645.3336398758522;1645.6790925769599;1646.1604581663437;1114.5876025870318;1118.2619471149003;1119.6193294279822;1130.1072152999202;1140.863096428434;6426.132472116298;6427.132337134521;6428.871422571522;6436.098946147543;6439.259485159173;6788.694508747119;6790.388865002074;6800.217974932847;6800.353966373186;6801;6307.211598550181;6418.679066046679;6428.935710642833;6430.871382572416;6434.64609446485;3647.0335361129323;3676.411774116182;3680.411134218512;3682.705383569308;3683.1896982664307;7046.330598593126;7048.506604537735;7053.224145344008;7057.4001209896705;7061.1173603299585;6531.11829902957;6729.663516824139;6866.249106477816;6877.4841886857685;7000.719971201095;6909.930900691029;7027.683754231072;7065.999999999897;7068.11648543932;7074.504784665127;6838.487113466609;6838.760643377458;6839.897401538881;6847.383735463832;6854.897176542256;6575.408213260829;6718.462522998246;6720.227173874871;6720.865582688417;6723.294054124247;6907.033015377951;7033.366996970297;7038.507304488841;7044.049053377933;7045.859082818418;4632.328312394617;4673.135469938073;4673.345731597511;4675.4856965734425;4683.203855344667;6670.631925666318;6795.422389096784;6804.897926531007;6812.352826481477;6813.148356455443;6601;6639.502037347315;6640.634765087966;6642.103316052271;6648.601083934979;6578.473722102316;6610.933890661032;6625.966870165618;6631.602103873783;6631.867362652816;6406.327335629878;6496.577722448026;6526.053722210158;6533.477321814148;6535.705893234721;6599.637019963756;6662.500312476681;6666.733330666719;6669.866602667822;6675.198976122896;6508.15393998796;6510.121133647087;6522.380373864476;6523.054157147282;6529.444997175293 17:23:58 INFO - 2016-02-25 17:23:58,758 DEBUG : BROWSER_OUTPUT: |5;yui.html;858.3862538285126;918.3342076994185;927.5733162745137;931.3573634192411;942.6559305853364;12549.68625784356;12755.617331480058;12827;12850.164739291962;12868.67828304293;11562.13284003699;12792.296423696693;12904.032197585171;12905.2902090385;12930.547430839899;707.1231672725809;877.2411863737852;890.6392910871075;891.1044400377612;892.1702816380763;900.9144131307515;901.8602116671926;906.4742449379344;909.9454032758056;910.1762904571374;741.1550832051465;750.3284560318511;945.5886689290146;949.1220620925651;949.2263804998904;922.3681777982071;932.072587775168;932.1563984593953;932.9580168892417;934.9298802589799;703.2159142556064;703.3669697272445;703.4231929817552;703.9753608623673;705.8764716174649;13157.802632960513;13292.800607990888;13317.13438626496;13353.86646133536;13354;11626.360550169737;11882.643520694393;11954.701132471671;12094.09294302922;12117.454714537867;10417.166626669848;10616.62841800541;10685.893141068567;10740.946295268473;10780.62461946921;3835.8657446989223;3867.091233560111;3880.398538226551;3904.1801221743185;3904.8047597620007;43706;43790.56209437897;46489.53510464886;47278.29082563764;47357.052858942625;9890.279095410953;10209.744756381002;10250.077493025663;10276.959222682424;10457.477126143815;18150.273989040554;18301.176447059916;18311.54221144482;18383.81616183821;18387.172577234058;7486.85026299471;7598.164201937893;7678.884816727754;7687.769366918889;7970.6413211405625;4363.650907927358;4379.934300985487;4419.801108950105;4447.688661793643;4469.5530446955045;3139.434901717667;3172.5241213818113;3172.682731726809;3176.6029246344206;3176.857041433141;546.4098773324799;553.139867506024;560.680412165062;561.3348182403864;562.6174201542908;689.7137687859482;696.373264062348;717.519262094398;726;737.310614575363;8070.47541909774;8072.071711753224;8081.151479094728;8265.256126948603;8416.676588482716;573.1774903014187;605.3129697793037;652.0154566604461;719.133444199738;721.7618185998608;3881.4177873319227;4146.274401979642;4147.336426171798;4167.541570427251;4255.276602977501;55608;65145;65579;66223;66603.33396666068;50856;51978.101642376976;52559.73720131375;53021;53374.73312633412;47768;47896.521034789206;48080.27879581809;48165.5183448168;49665.99999999928;8547.700830470903;8936.553172341228;8983.281337493116;8993.820123597361;9127.13292237263;35154.296914062084;36155.457668135525;36333.45499817558;36339.818300909385;36388.81805591061;43656.78171609122;44703.32945005762;45840.312395314766;46127;46522.534774651824;11195.328280303207;11365.090792736395;11546.59586914454;11668.591599293984;11692.123090768056;12573.434195461408;12600.369981501071;12756.936215318863;13147.934260328637;13404.865951340362;10835.67492975212;11337.319760814047;11762.176647634584;11806.586769463027;11808.468618912342;11548.826767598324;11623.360715160747;11629.88370116288;11735.41322933867;11773.293602383885;10479.941590467748;10948.124150068135;11044.061254793432;11067.446627668423;11395.373254471084;10449.216308777024;10557.683269501927;10662;10803.243772935819;11060.22578419535;9833.901660983298;10084.798304033731;10138.138258248131;10147.543360548645;10222.284440089123 17:23:58 INFO - 2016-02-25 17:23:58,758 DEBUG : BROWSER_OUTPUT: __end_tp_report 17:23:58 INFO - 2016-02-25 17:23:58,758 DEBUG : BROWSER_OUTPUT: __start_cc_report 17:23:58 INFO - 2016-02-25 17:23:58,758 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,727 17:23:58 INFO - 2016-02-25 17:23:58,758 DEBUG : BROWSER_OUTPUT: __end_cc_report 17:23:58 INFO - 2016-02-25 17:23:58,759 DEBUG : BROWSER_OUTPUT: __startTimestamp1456449838749__endTimestamp 17:23:58 INFO - 2016-02-25 17:23:58,759 DEBUG : BROWSER_OUTPUT: 17:23:58 INFO - 2016-02-25 17:23:58,759 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 17:23:58 INFO - 2016-02-25 17:23:58,759 DEBUG : BROWSER_OUTPUT: Number of tests: 6 17:23:58 INFO - 2016-02-25 17:23:58,759 DEBUG : BROWSER_OUTPUT: 17:23:58 INFO - 2016-02-25 17:23:58,759 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5463.76 Median:5656.41 stddev:600.63 (10.6%) stddev-sans-first:576.10 17:23:58 INFO - 2016-02-25 17:23:58,759 DEBUG : BROWSER_OUTPUT: Values: 3220.1 3304.2 3327.8 3329.0 3359.7 5334.0 5439.6 5445.4 5478.6 5490.3 5431.2 5464.1 5475.7 5477.4 5504.5 4822.4 4971.0 5056.8 5082.7 5120.7 4903.4 4959.4 5027.1 5031.4 5031.6 4993.0 5023.7 5062.0 5081.4 5088.8 5067.9 5116.9 5122.5 5134.8 5161.1 4825.5 4856.3 5038.0 5047.5 5101.1 5145.7 5234.3 5245.1 5246.6 5256.8 5865.8 5885.4 5933.2 5933.7 5934.3 5636.1 5768.7 5838.1 5949.9 5963.0 5563.6 5612.6 5615.2 5616.3 5616.5 6058.3 6062.5 6068.4 6068.4 6074.7 5618.2 5731.4 5781.5 5901.4 5902.8 5967.8 5970.5 5970.6 5972.1 6007.2 5870.1 5921.9 5925.4 5934.7 5937.3 5658.3 5724.9 5865.4 5938.4 5949.5 4484.3 4497.5 4521.8 4524.4 4547.3 4080.9 4082.1 4085.0 4086.2 4113.4 5396.6 5493.8 5521.1 5623.9 5653.1 5873.1 5894.8 5910.7 5913.9 5919.3 5574.9 5604.5 5612.1 5612.6 5612.8 4921.8 5017.5 5032.2 5107.6 5146.2 6085.8 6091.9 6094.8 6102.0 6102.4 5653.4 5912.9 5919.9 5930.2 5930.8 5911.1 5987.8 6091.1 6093.5 6126.3 5743.4 5782.5 5795.0 5805.8 5810.2 5682.5 5802.9 5876.9 5883.4 5898.2 5656.4 5736.5 5739.1 5739.6 5778.4 5740.4 5779.0 5780.1 5782.0 5787.0 5403.0 5525.1 5545.3 5673.0 5692.1 5714.9 5734.5 5744.4 5746.4 5783.2 5633.9 5663.0 5667.5 5671.2 5672.4 17:23:58 INFO - 2016-02-25 17:23:58,759 DEBUG : BROWSER_OUTPUT: 17:23:58 INFO - 2016-02-25 17:23:58,759 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:50393.29 Median:36035.23 stddev:85411.12 (237.0%) stddev-sans-first:85568.73 17:23:58 INFO - 2016-02-25 17:23:58,759 DEBUG : BROWSER_OUTPUT: Values: 549.5 586.9 593.1 593.6 604.0 31343.0 41935.0 42408.4 42429.2 42521.1 46361.5 47180.5 47196.3 47246.3 47271.0 7710.4 7826.0 8939.6 9206.0 9237.4 10722.3 10934.9 10936.0 10949.1 10949.4 10793.9 10926.2 10928.5 10932.8 10941.0 7932.4 8134.2 10688.8 10776.4 11060.2 10624.1 10708.3 10711.1 10732.2 10774.6 42841.0 43335.1 43350.1 43382.6 43392.6 3331.9 3384.2 3484.3 3847.3 4156.3 32279.7 32500.0 32527.7 32689.2 32704.2 4222.0 4352.3 4388.5 4397.1 4404.2 306177.0 306603.0 307322.0 307854.0 309552.5 64284.4 64679.0 64709.0 64764.7 64834.0 57099.1 58303.4 67727.7 68226.0 68791.3 16799.2 17011.1 17019.6 17073.3 17082.1 13079.2 13156.6 13163.1 13163.9 13169.1 20627.5 20725.9 20990.6 21030.5 21032.0 7805.2 7942.3 7963.2 8015.0 8066.5 943.9 1025.8 1083.3 1100.5 1101.3 29535.9 29584.9 29998.6 30519.4 30972.0 1105.4 1113.3 1197.9 1203.9 1283.3 13360.5 15554.2 15963.7 16059.4 16112.4 409216.0 412768.0 413190.0 414953.0 417048.0 48235.8 62000.4 62780.7 62782.4 62936.0 1340.4 1400.3 1490.5 1492.0 1500.5 31711.7 31798.4 31956.2 32471.8 32712.8 46972.8 47491.5 47516.5 47556.8 47704.8 220956.0 221799.0 223910.0 228393.0 245008.0 34994.8 36052.8 36176.0 36229.8 36405.1 46300.1 46869.5 47310.0 47833.5 48097.5 39443.2 39872.8 40527.1 41056.0 41152.8 40079.4 40307.0 40679.4 40909.8 41108.0 39231.6 39562.8 39762.8 39766.6 39789.0 34599.5 35493.0 35607.3 36017.6 36073.8 26535.9 27134.9 27382.3 27390.2 27418.9 17:23:58 INFO - 2016-02-25 17:23:58,759 DEBUG : BROWSER_OUTPUT: 17:23:58 INFO - 2016-02-25 17:23:58,759 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:32488.83 Median:2592.74 stddev:104624.45 (4035.3%) stddev-sans-first:104890.15 17:23:58 INFO - 2016-02-25 17:23:58,761 DEBUG : BROWSER_OUTPUT: Values: 371.4 374.2 374.8 375.6 377.4 17329.0 18272.6 18427.8 18566.9 19779.0 18121.6 18424.4 18607.9 18720.3 18774.4 4206.7 4315.9 5000.2 5607.4 5609.5 4277.1 5923.2 6169.5 6185.1 6190.6 5996.7 6087.1 6179.0 6184.6 6185.0 4203.2 4309.5 5970.6 6075.8 6090.1 5443.6 5447.6 5461.8 5461.9 5468.3 20682.8 21953.5 22461.8 22473.6 22611.8 2413.5 2415.1 2481.9 2513.9 2671.6 14358.0 14421.1 14446.8 14769.3 14824.3 1981.3 1990.1 2007.7 2047.8 2051.9 63982.4 65065.0 65647.7 66828.3 67451.3 10507.0 10687.6 10740.2 10800.5 10888.2 14189.9 14242.1 14253.1 14271.4 14286.1 8303.0 8398.4 8588.1 8622.8 8638.7 8537.5 8552.7 8566.6 8627.5 8628.1 6385.7 6466.0 6468.5 6483.3 6483.9 1738.9 1785.4 1812.5 1839.2 1869.2 943.0 974.7 1016.7 1022.7 1044.7 16882.2 17076.9 17199.3 17334.2 17690.3 876.5 970.3 982.6 989.0 1030.0 9384.4 9930.8 10261.7 10293.7 10364.2 626209.0 633769.0 637241.0 653177.0 654606.0 84606.0 86493.6 87275.6 87605.6 88703.1 1245.1 1246.3 1249.8 1252.0 1265.4 15115.7 15676.5 15865.7 16275.6 16369.7 32810.5 32932.5 32998.0 33522.5 34120.1 38747.8 40322.8 40741.4 41666.0 44664.3 9705.9 9762.7 9911.7 9919.8 9929.1 18110.6 18432.6 18519.2 18770.0 18997.5 14921.7 15460.2 15726.0 15736.0 15975.4 15105.5 15113.0 15184.9 15680.0 15846.8 15411.3 15725.2 15755.7 15934.0 16262.8 9517.0 9677.6 9696.5 9790.3 9850.3 10133.3 12114.5 15130.8 15451.6 15526.6 17:23:58 INFO - 2016-02-25 17:23:58,761 DEBUG : BROWSER_OUTPUT: 17:23:58 INFO - 2016-02-25 17:23:58,761 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5601.64 Median:6690.75 stddev:2991.33 (44.7%) stddev-sans-first:2984.25 17:23:58 INFO - 2016-02-25 17:23:58,762 DEBUG : BROWSER_OUTPUT: Values: 1554.2 1555.9 1751.6 1775.3 1830.9 7883.4 8280.6 8288.5 8292.4 8294.9 8034.8 8108.1 8129.5 8135.8 8137.2 2232.1 2235.2 2268.7 2271.2 2271.6 2303.4 2334.2 2335.0 2335.7 2337.5 1914.5 1956.9 1957.1 2216.6 2303.7 2200.4 2255.3 2256.1 2258.1 2258.3 2263.4 2264.4 2294.4 2296.0 2325.7 6683.3 6902.1 7743.3 8092.0 8193.0 4719.9 4815.0 4815.8 4851.2 4855.9 2980.1 3003.9 3036.4 3040.6 3059.2 934.0 936.2 946.5 967.4 979.0 11042.3 11078.1 11102.4 11106.5 11109.3 4179.7 4183.2 4241.9 4242.5 4251.4 9638.3 9649.4 9659.8 9670.5 9685.9 4639.6 4669.7 4676.1 4677.7 4683.0 4203.1 4204.5 4206.1 4210.3 4210.5 3509.7 3576.8 3597.7 3598.3 3599.2 1021.4 1042.5 1045.1 1061.6 1065.5 1393.6 1414.7 1450.2 1459.7 1465.8 7559.8 7583.4 7611.5 7650.1 7652.8 447.8 453.4 454.8 456.5 457.0 5193.5 5856.0 5896.8 5907.7 5908.0 8682.3 9322.0 9498.1 9573.3 9589.1 9325.4 9389.6 9442.0 9476.4 9723.1 7661.5 7668.5 7679.2 7696.8 7738.1 7390.1 7408.5 7468.7 7484.9 7522.4 8562.0 8641.2 8739.9 8769.2 8815.9 8913.5 8922.7 9014.0 9040.8 9042.1 7191.6 7296.6 7394.1 7403.7 7407.1 7812.5 7917.3 7952.2 7966.3 7974.4 7402.3 7431.6 7489.3 7494.3 7511.1 7381.9 7395.5 7401.1 7479.6 7481.6 7143.2 7150.2 7197.1 7217.0 7291.6 6636.0 6645.2 6648.9 6661.5 6664.2 6698.2 6725.3 6812.8 6815.7 6835.7 17:23:58 INFO - 2016-02-25 17:23:58,763 DEBUG : BROWSER_OUTPUT: 17:23:58 INFO - 2016-02-25 17:23:58,763 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5497.49 Median:6356.77 stddev:1655.90 (26.0%) stddev-sans-first:1614.77 17:23:58 INFO - 2016-02-25 17:23:58,763 DEBUG : BROWSER_OUTPUT: Values: 345.7 347.0 348.2 349.0 356.7 6072.1 6113.6 6140.6 6148.2 6218.7 6052.4 6065.5 6066.1 6073.1 6079.7 4642.4 4655.5 4703.7 4721.4 4723.6 4712.8 4725.5 4726.5 4728.0 4734.9 4675.7 4677.0 4678.0 4689.2 4689.5 4481.6 4550.9 4579.2 4686.7 4720.7 4144.3 4162.0 4173.4 4180.4 4183.1 5661.2 5847.6 5857.4 5859.2 5862.9 5357.8 5392.4 5517.0 5520.3 5521.9 6425.8 6445.8 6451.9 6459.2 6459.9 4622.8 4624.1 4626.7 4629.6 4629.9 6629.5 6702.8 6718.0 6725.2 6730.0 4744.4 4755.5 4758.2 4759.0 4763.9 4776.4 4784.6 4787.2 4789.7 4793.9 5269.7 5478.6 5483.6 5492.2 5495.5 6556.1 6564.1 6564.3 6573.9 6576.0 1633.0 1644.4 1645.3 1645.7 1646.2 1114.6 1118.3 1119.6 1130.1 1140.9 6426.1 6427.1 6428.9 6436.1 6439.3 6788.7 6790.4 6800.2 6800.4 6801.0 6307.2 6418.7 6428.9 6430.9 6434.6 3647.0 3676.4 3680.4 3682.7 3683.2 7046.3 7048.5 7053.2 7057.4 7061.1 6531.1 6729.7 6866.2 6877.5 7000.7 6909.9 7027.7 7066.0 7068.1 7074.5 6838.5 6838.8 6839.9 6847.4 6854.9 6575.4 6718.5 6720.2 6720.9 6723.3 6907.0 7033.4 7038.5 7044.0 7045.9 4632.3 4673.1 4673.3 4675.5 4683.2 6670.6 6795.4 6804.9 6812.4 6813.1 6601.0 6639.5 6640.6 6642.1 6648.6 6578.5 6610.9 6626.0 6631.6 6631.9 6406.3 6496.6 6526.1 6533.5 6535.7 6599.6 6662.5 6666.7 6669.9 6675.2 6508.2 6510.1 6522.4 6523.1 6529.4 17:23:58 INFO - 2016-02-25 17:23:58,763 DEBUG : BROWSER_OUTPUT: 17:23:58 INFO - 2016-02-25 17:23:58,764 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14118.63 Median:24042.97 stddev:16561.39 (68.9%) stddev-sans-first:16577.91 17:23:58 INFO - 2016-02-25 17:23:58,766 DEBUG : BROWSER_OUTPUT: Values: 858.4 918.3 927.6 931.4 942.7 12549.7 12755.6 12827.0 12850.2 12868.7 11562.1 12792.3 12904.0 12905.3 12930.5 707.1 877.2 890.6 891.1 892.2 900.9 901.9 906.5 909.9 910.2 741.2 750.3 945.6 949.1 949.2 922.4 932.1 932.2 933.0 934.9 703.2 703.4 703.4 704.0 705.9 13157.8 13292.8 13317.1 13353.9 13354.0 11626.4 11882.6 11954.7 12094.1 12117.5 10417.2 10616.6 10685.9 10740.9 10780.6 3835.9 3867.1 3880.4 3904.2 3904.8 43706.0 43790.6 46489.5 47278.3 47357.1 9890.3 10209.7 10250.1 10277.0 10457.5 18150.3 18301.2 18311.5 18383.8 18387.2 7486.9 7598.2 7678.9 7687.8 7970.6 4363.7 4379.9 4419.8 4447.7 4469.6 3139.4 3172.5 3172.7 3176.6 3176.9 546.4 553.1 560.7 561.3 562.6 689.7 696.4 717.5 726.0 737.3 8070.5 8072.1 8081.2 8265.3 8416.7 573.2 605.3 652.0 719.1 721.8 3881.4 4146.3 4147.3 4167.5 4255.3 55608.0 65145.0 65579.0 66223.0 66603.3 50856.0 51978.1 52559.7 53021.0 53374.7 47768.0 47896.5 48080.3 48165.5 49666.0 8547.7 8936.6 8983.3 8993.8 9127.1 35154.3 36155.5 36333.5 36339.8 36388.8 43656.8 44703.3 45840.3 46127.0 46522.5 11195.3 11365.1 11546.6 11668.6 11692.1 12573.4 12600.4 12756.9 13147.9 13404.9 10835.7 11337.3 11762.2 11806.6 11808.5 11548.8 11623.4 11629.9 11735.4 11773.3 10479.9 10948.1 11044.1 11067.4 11395.4 10449.2 10557.7 10662.0 10803.2 11060.2 9833.9 10084.8 10138.1 10147.5 10222.3 17:23:58 INFO - 2016-02-25 17:23:58,766 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 17:23:58 INFO - 2016-02-25 17:23:58,766 DEBUG : BROWSER_OUTPUT: 17:23:59 INFO - 2016-02-25 17:23:59,361 INFO : Browser exited with error code: 0 17:23:59 INFO - 2016-02-25 17:23:59,382 INFO : Completed test dromaeo_css (00:18:30) 17:23:59 INFO - 2016-02-25 17:23:59,383 INFO : Starting test kraken 17:23:59 INFO - 2016-02-25 17:23:59,383 DEBUG : operating with platform_type : linux_ 17:23:59 INFO - 2016-02-25 17:23:59,383 INFO : Initialising browser for kraken test... 17:23:59 INFO - 2016-02-25 17:23:59,389 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpW43LXX/profile http://localhost:32792/getInfo.html 17:24:04 INFO - 2016-02-25 17:24:04,040 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 17:24:04 INFO - 2016-02-25 17:24:04,040 DEBUG : BROWSER_OUTPUT: colorDepth:24 17:24:04 INFO - 2016-02-25 17:24:04,040 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 17:24:04 INFO - 2016-02-25 17:24:04,040 DEBUG : BROWSER_OUTPUT: __metrics 17:24:04 INFO - 2016-02-25 17:24:04,241 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] 17:24:05 INFO - 2016-02-25 17:24:05,173 INFO : Browser initialized. 17:24:05 INFO - 2016-02-25 17:24:05,174 INFO : Running cycle 1/1 for kraken test... 17:24:05 INFO - 2016-02-25 17:24:05,174 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpW43LXX/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 17:24:16 INFO - 2016-02-25 17:24:16,843 DEBUG : BROWSER_OUTPUT: RSS: Main: 134840320 17:24:16 INFO - 2016-02-25 17:24:16,843 DEBUG : BROWSER_OUTPUT: 17:24:19 INFO - 2016-02-25 17:24:19,302 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32792/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:32792/tests/kraken/driver.html?testName=audio-beat-detection) 17:24:19 INFO - 2016-02-25 17:24:19,884 DEBUG : BROWSER_OUTPUT: RSS: Main: 163483648 17:24:19 INFO - 2016-02-25 17:24:19,885 DEBUG : BROWSER_OUTPUT: 17:24:22 INFO - 2016-02-25 17:24:22,446 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32792/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:32792/tests/kraken/driver.html?testName=audio-dft) 17:24:23 INFO - 2016-02-25 17:24:23,011 DEBUG : BROWSER_OUTPUT: RSS: Main: 161902592 17:24:23 INFO - 2016-02-25 17:24:23,011 DEBUG : BROWSER_OUTPUT: 17:24:25 INFO - 2016-02-25 17:24:25,798 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32792/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:32792/tests/kraken/driver.html?testName=audio-fft) 17:24:26 INFO - 2016-02-25 17:24:26,370 DEBUG : BROWSER_OUTPUT: RSS: Main: 159772672 17:24:26 INFO - 2016-02-25 17:24:26,371 DEBUG : BROWSER_OUTPUT: 17:24:28 INFO - 2016-02-25 17:24:28,363 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32792/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:32792/tests/kraken/driver.html?testName=audio-oscillator) 17:24:28 INFO - 2016-02-25 17:24:28,924 DEBUG : BROWSER_OUTPUT: RSS: Main: 158851072 17:24:28 INFO - 2016-02-25 17:24:28,924 DEBUG : BROWSER_OUTPUT: 17:24:31 INFO - 2016-02-25 17:24:31,098 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32792/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:32792/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:24:31 INFO - 2016-02-25 17:24:31,668 DEBUG : BROWSER_OUTPUT: RSS: Main: 158867456 17:24:31 INFO - 2016-02-25 17:24:31,668 DEBUG : BROWSER_OUTPUT: 17:24:34 INFO - 2016-02-25 17:24:34,494 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32792/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:32792/tests/kraken/driver.html?testName=imaging-darkroom) 17:24:35 INFO - 2016-02-25 17:24:35,064 DEBUG : BROWSER_OUTPUT: RSS: Main: 158605312 17:24:35 INFO - 2016-02-25 17:24:35,064 DEBUG : BROWSER_OUTPUT: 17:24:38 INFO - 2016-02-25 17:24:38,378 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32792/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:32792/tests/kraken/driver.html?testName=imaging-desaturate) 17:24:38 INFO - 2016-02-25 17:24:38,952 DEBUG : BROWSER_OUTPUT: RSS: Main: 157544448 17:24:38 INFO - 2016-02-25 17:24:38,952 DEBUG : BROWSER_OUTPUT: 17:24:41 INFO - 2016-02-25 17:24:41,637 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32792/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:32792/tests/kraken/driver.html?testName=json-parse-financial) 17:24:42 INFO - 2016-02-25 17:24:42,204 DEBUG : BROWSER_OUTPUT: RSS: Main: 157888512 17:24:42 INFO - 2016-02-25 17:24:42,204 DEBUG : BROWSER_OUTPUT: 17:24:43 INFO - 2016-02-25 17:24:43,721 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32792/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:32792/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:24:44 INFO - 2016-02-25 17:24:44,282 DEBUG : BROWSER_OUTPUT: RSS: Main: 166047744 17:24:44 INFO - 2016-02-25 17:24:44,283 DEBUG : BROWSER_OUTPUT: 17:24:46 INFO - 2016-02-25 17:24:46,036 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32792/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:32792/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:24:46 INFO - 2016-02-25 17:24:46,630 DEBUG : BROWSER_OUTPUT: RSS: Main: 163938304 17:24:46 INFO - 2016-02-25 17:24:46,630 DEBUG : BROWSER_OUTPUT: 17:24:48 INFO - 2016-02-25 17:24:48,605 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32792/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:32792/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:24:49 INFO - 2016-02-25 17:24:49,180 DEBUG : BROWSER_OUTPUT: RSS: Main: 169848832 17:24:49 INFO - 2016-02-25 17:24:49,180 DEBUG : BROWSER_OUTPUT: 17:24:51 INFO - 2016-02-25 17:24:51,522 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32792/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:32792/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:24:52 INFO - 2016-02-25 17:24:52,103 DEBUG : BROWSER_OUTPUT: RSS: Main: 174587904 17:24:52 INFO - 2016-02-25 17:24:52,104 DEBUG : BROWSER_OUTPUT: 17:24:54 INFO - 2016-02-25 17:24:54,563 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32792/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:32792/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:24:55 INFO - 2016-02-25 17:24:55,129 DEBUG : BROWSER_OUTPUT: RSS: Main: 171401216 17:24:55 INFO - 2016-02-25 17:24:55,130 DEBUG : BROWSER_OUTPUT: 17:24:56 INFO - 2016-02-25 17:24:56,785 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32792/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:32792/tests/kraken/driver.html?testName=ai-astar) 17:24:57 INFO - 2016-02-25 17:24:57,035 DEBUG : BROWSER_OUTPUT: RSS: Main: 230871040 17:24:57 INFO - 2016-02-25 17:24:57,036 DEBUG : BROWSER_OUTPUT: 17:24:57 INFO - 2016-02-25 17:24:57,036 DEBUG : BROWSER_OUTPUT: __start_tp_report 17:24:57 INFO - 2016-02-25 17:24:57,036 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 17:24:57 INFO - 2016-02-25 17:24:57,036 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 17:24:57 INFO - 2016-02-25 17:24:57,037 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 17:24:57 INFO - 2016-02-25 17:24:57,037 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;111;104;108;109;110;99;108;108;116 17:24:57 INFO - 2016-02-25 17:24:57,037 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;154;126;146;154;122;148;146;129;170;123 17:24:57 INFO - 2016-02-25 17:24:57,037 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;159;160;161;160;160;159;161;160;160 17:24:57 INFO - 2016-02-25 17:24:57,037 DEBUG : BROWSER_OUTPUT: |3;audio-fft;70;75;73;147;72;71;72;80;153;71 17:24:57 INFO - 2016-02-25 17:24:57,037 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;93;144;92;93;93;136;93;93;136 17:24:57 INFO - 2016-02-25 17:24:57,037 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;109;109;110;109;110;109;109;108 17:24:57 INFO - 2016-02-25 17:24:57,037 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;145;146;145;145;146;145;146;145;146 17:24:57 INFO - 2016-02-25 17:24:57,038 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;96;96;95;96;95;95;95;95 17:24:57 INFO - 2016-02-25 17:24:57,038 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;56;56;58;55;56;56;58;58;54;54 17:24:57 INFO - 2016-02-25 17:24:57,038 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;64;64;63;64;65;65;64;64;64;64 17:24:57 INFO - 2016-02-25 17:24:57,038 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;76;78;78;79;79;80;78;80;80;87 17:24:57 INFO - 2016-02-25 17:24:57,038 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;120;113;118;117;122;113;119;120;110;111 17:24:57 INFO - 2016-02-25 17:24:57,038 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;131;150;145;140;142;131;135;142;141;131 17:24:57 INFO - 2016-02-25 17:24:57,038 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;64;68;66;64;63;63;63;64;63;65 17:24:57 INFO - 2016-02-25 17:24:57,038 DEBUG : BROWSER_OUTPUT: __end_tp_report 17:24:57 INFO - 2016-02-25 17:24:57,038 DEBUG : BROWSER_OUTPUT: __start_cc_report 17:24:57 INFO - 2016-02-25 17:24:57,038 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,906 17:24:57 INFO - 2016-02-25 17:24:57,038 DEBUG : BROWSER_OUTPUT: __end_cc_report 17:24:57 INFO - 2016-02-25 17:24:57,038 DEBUG : BROWSER_OUTPUT: __startTimestamp1456449897035__endTimestamp 17:24:57 INFO - 2016-02-25 17:24:57,038 DEBUG : BROWSER_OUTPUT: 17:24:57 INFO - 2016-02-25 17:24:57,042 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 17:24:57 INFO - 2016-02-25 17:24:57,042 DEBUG : BROWSER_OUTPUT: Number of tests: 14 17:24:57 INFO - 2016-02-25 17:24:57,042 DEBUG : BROWSER_OUTPUT: 17:24:57 INFO - 2016-02-25 17:24:57,042 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.20 Median:109.50 stddev:4.42 (4.0%) stddev-sans-first:4.68 17:24:57 INFO - 2016-02-25 17:24:57,042 DEBUG : BROWSER_OUTPUT: Values: 109.0 111.0 104.0 108.0 109.0 110.0 99.0 108.0 108.0 116.0 17:24:57 INFO - 2016-02-25 17:24:57,042 DEBUG : BROWSER_OUTPUT: 17:24:57 INFO - 2016-02-25 17:24:57,042 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:141.80 Median:147.00 stddev:16.07 (10.9%) stddev-sans-first:16.43 17:24:57 INFO - 2016-02-25 17:24:57,042 DEBUG : BROWSER_OUTPUT: Values: 154.0 126.0 146.0 154.0 122.0 148.0 146.0 129.0 170.0 123.0 17:24:57 INFO - 2016-02-25 17:24:57,042 DEBUG : BROWSER_OUTPUT: 17:24:57 INFO - 2016-02-25 17:24:57,042 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.00 Median:160.00 stddev:0.67 (0.4%) stddev-sans-first:0.71 17:24:57 INFO - 2016-02-25 17:24:57,042 DEBUG : BROWSER_OUTPUT: Values: 160.0 159.0 160.0 161.0 160.0 160.0 159.0 161.0 160.0 160.0 17:24:57 INFO - 2016-02-25 17:24:57,042 DEBUG : BROWSER_OUTPUT: 17:24:57 INFO - 2016-02-25 17:24:57,042 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:88.40 Median:72.00 stddev:32.62 (45.3%) stddev-sans-first:33.91 17:24:57 INFO - 2016-02-25 17:24:57,042 DEBUG : BROWSER_OUTPUT: Values: 70.0 75.0 73.0 147.0 72.0 71.0 72.0 80.0 153.0 71.0 17:24:57 INFO - 2016-02-25 17:24:57,043 DEBUG : BROWSER_OUTPUT: 17:24:57 INFO - 2016-02-25 17:24:57,043 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.60 Median:93.00 stddev:22.24 (23.9%) stddev-sans-first:23.03 17:24:57 INFO - 2016-02-25 17:24:57,043 DEBUG : BROWSER_OUTPUT: Values: 93.0 93.0 144.0 92.0 93.0 93.0 136.0 93.0 93.0 136.0 17:24:57 INFO - 2016-02-25 17:24:57,043 DEBUG : BROWSER_OUTPUT: 17:24:57 INFO - 2016-02-25 17:24:57,043 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.50 stddev:0.67 (0.6%) stddev-sans-first:0.67 17:24:57 INFO - 2016-02-25 17:24:57,043 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 109.0 109.0 110.0 109.0 110.0 109.0 109.0 108.0 17:24:57 INFO - 2016-02-25 17:24:57,043 DEBUG : BROWSER_OUTPUT: 17:24:57 INFO - 2016-02-25 17:24:57,043 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 17:24:57 INFO - 2016-02-25 17:24:57,044 DEBUG : BROWSER_OUTPUT: Values: 145.0 145.0 146.0 145.0 145.0 146.0 145.0 146.0 145.0 146.0 17:24:57 INFO - 2016-02-25 17:24:57,044 DEBUG : BROWSER_OUTPUT: 17:24:57 INFO - 2016-02-25 17:24:57,044 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 17:24:57 INFO - 2016-02-25 17:24:57,044 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 96.0 96.0 95.0 96.0 95.0 95.0 95.0 95.0 17:24:57 INFO - 2016-02-25 17:24:57,044 DEBUG : BROWSER_OUTPUT: 17:24:57 INFO - 2016-02-25 17:24:57,044 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:56.10 Median:56.00 stddev:1.52 (2.7%) stddev-sans-first:1.62 17:24:57 INFO - 2016-02-25 17:24:57,044 DEBUG : BROWSER_OUTPUT: Values: 56.0 56.0 58.0 55.0 56.0 56.0 58.0 58.0 54.0 54.0 17:24:57 INFO - 2016-02-25 17:24:57,044 DEBUG : BROWSER_OUTPUT: 17:24:57 INFO - 2016-02-25 17:24:57,044 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:64.10 Median:64.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 17:24:57 INFO - 2016-02-25 17:24:57,044 DEBUG : BROWSER_OUTPUT: Values: 64.0 64.0 63.0 64.0 65.0 65.0 64.0 64.0 64.0 64.0 17:24:57 INFO - 2016-02-25 17:24:57,044 DEBUG : BROWSER_OUTPUT: 17:24:57 INFO - 2016-02-25 17:24:57,044 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:79.50 Median:79.50 stddev:2.92 (3.7%) stddev-sans-first:2.80 17:24:57 INFO - 2016-02-25 17:24:57,044 DEBUG : BROWSER_OUTPUT: Values: 76.0 78.0 78.0 79.0 79.0 80.0 78.0 80.0 80.0 87.0 17:24:57 INFO - 2016-02-25 17:24:57,044 DEBUG : BROWSER_OUTPUT: 17:24:57 INFO - 2016-02-25 17:24:57,044 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:116.30 Median:118.50 stddev:4.22 (3.6%) stddev-sans-first:4.26 17:24:57 INFO - 2016-02-25 17:24:57,044 DEBUG : BROWSER_OUTPUT: Values: 120.0 113.0 118.0 117.0 122.0 113.0 119.0 120.0 110.0 111.0 17:24:57 INFO - 2016-02-25 17:24:57,045 DEBUG : BROWSER_OUTPUT: 17:24:57 INFO - 2016-02-25 17:24:57,045 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:138.80 Median:141.50 stddev:6.56 (4.6%) stddev-sans-first:6.32 17:24:57 INFO - 2016-02-25 17:24:57,045 DEBUG : BROWSER_OUTPUT: Values: 131.0 150.0 145.0 140.0 142.0 131.0 135.0 142.0 141.0 131.0 17:24:57 INFO - 2016-02-25 17:24:57,045 DEBUG : BROWSER_OUTPUT: 17:24:57 INFO - 2016-02-25 17:24:57,045 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.30 Median:64.00 stddev:1.64 (2.6%) stddev-sans-first:1.73 17:24:57 INFO - 2016-02-25 17:24:57,045 DEBUG : BROWSER_OUTPUT: Values: 64.0 68.0 66.0 64.0 63.0 63.0 63.0 64.0 63.0 65.0 17:24:57 INFO - 2016-02-25 17:24:57,045 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 17:24:57 INFO - 2016-02-25 17:24:57,045 DEBUG : BROWSER_OUTPUT: 17:24:57 INFO - 2016-02-25 17:24:57,778 INFO : Browser exited with error code: 0 17:24:57 INFO - 2016-02-25 17:24:57,834 INFO : Completed test kraken (00:00:58) 17:24:57 INFO - 2016-02-25 17:24:57,834 INFO : Starting test v8_7 17:24:57 INFO - 2016-02-25 17:24:57,834 DEBUG : operating with platform_type : linux_ 17:24:57 INFO - 2016-02-25 17:24:57,834 INFO : Initialising browser for v8_7 test... 17:24:57 INFO - 2016-02-25 17:24:57,840 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmphfVqWj/profile http://localhost:32792/getInfo.html 17:25:02 INFO - 2016-02-25 17:25:02,065 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 17:25:02 INFO - 2016-02-25 17:25:02,065 DEBUG : BROWSER_OUTPUT: colorDepth:24 17:25:02 INFO - 2016-02-25 17:25:02,065 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 17:25:02 INFO - 2016-02-25 17:25:02,065 DEBUG : BROWSER_OUTPUT: __metrics 17:25:02 INFO - 2016-02-25 17:25:02,234 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] 17:25:03 INFO - 2016-02-25 17:25:03,537 INFO : Browser initialized. 17:25:03 INFO - 2016-02-25 17:25:03,538 INFO : Running cycle 1/1 for v8_7 test... 17:25:03 INFO - 2016-02-25 17:25:03,538 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmphfVqWj/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 17:25:15 INFO - 2016-02-25 17:25:15,212 DEBUG : BROWSER_OUTPUT: RSS: Main: 134979584 17:25:15 INFO - 2016-02-25 17:25:15,212 DEBUG : BROWSER_OUTPUT: 17:25:36 INFO - 2016-02-25 17:25:36,583 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32792/tests/v8_7/run.html (next: http://localhost:32792/tests/v8_7/run.html) 17:25:36 INFO - 2016-02-25 17:25:36,829 DEBUG : BROWSER_OUTPUT: RSS: Main: 422731776 17:25:36 INFO - 2016-02-25 17:25:36,830 DEBUG : BROWSER_OUTPUT: 17:25:36 INFO - 2016-02-25 17:25:36,831 DEBUG : BROWSER_OUTPUT: __start_tp_report 17:25:36 INFO - 2016-02-25 17:25:36,831 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 17:25:36 INFO - 2016-02-25 17:25:36,831 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 17:25:36 INFO - 2016-02-25 17:25:36,831 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 17:25:36 INFO - 2016-02-25 17:25:36,832 DEBUG : BROWSER_OUTPUT: |0;Richards;167.81339150864238 17:25:36 INFO - 2016-02-25 17:25:36,832 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;164.50074025333114 17:25:36 INFO - 2016-02-25 17:25:36,832 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.9400278940028 17:25:36 INFO - 2016-02-25 17:25:36,832 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5191.709844559586 17:25:36 INFO - 2016-02-25 17:25:36,832 DEBUG : BROWSER_OUTPUT: |4;RayTrace;942.5070688030161 17:25:36 INFO - 2016-02-25 17:25:36,832 DEBUG : BROWSER_OUTPUT: |5;Earley;540.5405405405405 17:25:36 INFO - 2016-02-25 17:25:36,832 DEBUG : BROWSER_OUTPUT: |6;Boyer;10891.304347826086 17:25:36 INFO - 2016-02-25 17:25:36,833 DEBUG : BROWSER_OUTPUT: |7;RegExp;24333.333333333332 17:25:36 INFO - 2016-02-25 17:25:36,833 DEBUG : BROWSER_OUTPUT: |8;Splay;521.1047420531527 17:25:36 INFO - 2016-02-25 17:25:36,833 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 17:25:36 INFO - 2016-02-25 17:25:36,833 DEBUG : BROWSER_OUTPUT: __end_tp_report 17:25:36 INFO - 2016-02-25 17:25:36,834 DEBUG : BROWSER_OUTPUT: __startTimestamp1456449936830__endTimestamp 17:25:36 INFO - 2016-02-25 17:25:36,834 DEBUG : BROWSER_OUTPUT: 17:25:36 INFO - 2016-02-25 17:25:36,834 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 17:25:36 INFO - 2016-02-25 17:25:36,834 DEBUG : BROWSER_OUTPUT: Number of tests: 10 17:25:36 INFO - 2016-02-25 17:25:36,834 DEBUG : BROWSER_OUTPUT: 17:25:36 INFO - 2016-02-25 17:25:36,834 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:167.81 Median:167.81 stddev:0.00 (0.0%) 17:25:36 INFO - 2016-02-25 17:25:36,835 DEBUG : BROWSER_OUTPUT: Values: 167.8 17:25:36 INFO - 2016-02-25 17:25:36,835 DEBUG : BROWSER_OUTPUT: 17:25:36 INFO - 2016-02-25 17:25:36,835 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:164.50 Median:164.50 stddev:0.00 (0.0%) 17:25:36 INFO - 2016-02-25 17:25:36,835 DEBUG : BROWSER_OUTPUT: Values: 164.5 17:25:36 INFO - 2016-02-25 17:25:36,835 DEBUG : BROWSER_OUTPUT: 17:25:36 INFO - 2016-02-25 17:25:36,835 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.94 Median:278.94 stddev:0.00 (0.0%) 17:25:36 INFO - 2016-02-25 17:25:36,836 DEBUG : BROWSER_OUTPUT: Values: 278.9 17:25:36 INFO - 2016-02-25 17:25:36,836 DEBUG : BROWSER_OUTPUT: 17:25:36 INFO - 2016-02-25 17:25:36,836 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5191.71 Median:5191.71 stddev:0.00 (0.0%) 17:25:36 INFO - 2016-02-25 17:25:36,836 DEBUG : BROWSER_OUTPUT: Values: 5191.7 17:25:36 INFO - 2016-02-25 17:25:36,836 DEBUG : BROWSER_OUTPUT: 17:25:36 INFO - 2016-02-25 17:25:36,836 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:942.51 Median:942.51 stddev:0.00 (0.0%) 17:25:36 INFO - 2016-02-25 17:25:36,836 DEBUG : BROWSER_OUTPUT: Values: 942.5 17:25:36 INFO - 2016-02-25 17:25:36,838 DEBUG : BROWSER_OUTPUT: 17:25:36 INFO - 2016-02-25 17:25:36,838 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:540.54 Median:540.54 stddev:0.00 (0.0%) 17:25:36 INFO - 2016-02-25 17:25:36,838 DEBUG : BROWSER_OUTPUT: Values: 540.5 17:25:36 INFO - 2016-02-25 17:25:36,838 DEBUG : BROWSER_OUTPUT: 17:25:36 INFO - 2016-02-25 17:25:36,838 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10891.30 Median:10891.30 stddev:0.00 (0.0%) 17:25:36 INFO - 2016-02-25 17:25:36,838 DEBUG : BROWSER_OUTPUT: Values: 10891.3 17:25:36 INFO - 2016-02-25 17:25:36,839 DEBUG : BROWSER_OUTPUT: 17:25:36 INFO - 2016-02-25 17:25:36,839 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24333.33 Median:24333.33 stddev:0.00 (0.0%) 17:25:36 INFO - 2016-02-25 17:25:36,839 DEBUG : BROWSER_OUTPUT: Values: 24333.3 17:25:36 INFO - 2016-02-25 17:25:36,839 DEBUG : BROWSER_OUTPUT: 17:25:36 INFO - 2016-02-25 17:25:36,839 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:521.10 Median:521.10 stddev:0.00 (0.0%) 17:25:36 INFO - 2016-02-25 17:25:36,839 DEBUG : BROWSER_OUTPUT: Values: 521.1 17:25:36 INFO - 2016-02-25 17:25:36,839 DEBUG : BROWSER_OUTPUT: 17:25:36 INFO - 2016-02-25 17:25:36,839 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 17:25:36 INFO - 2016-02-25 17:25:36,840 DEBUG : BROWSER_OUTPUT: Values: 4835.7 17:25:36 INFO - 2016-02-25 17:25:36,840 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 17:25:36 INFO - 2016-02-25 17:25:36,840 DEBUG : BROWSER_OUTPUT: 17:25:37 INFO - 2016-02-25 17:25:37,605 INFO : Browser exited with error code: 0 17:25:37 INFO - 2016-02-25 17:25:37,622 INFO : Completed test v8_7 (00:00:39) 17:25:37 INFO - 2016-02-25 17:25:37,870 INFO : Completed test suite (00:20:09) 17:25:37 INFO - 2016-02-25 17:25:37,871 DEBUG : Working with test: dromaeo_css 17:25:37 INFO - 2016-02-25 17:25:37,871 DEBUG : Generating results file: dromaeo_css 17:25:37 INFO - 2016-02-25 17:25:37,872 DEBUG : Working with test: kraken 17:25:37 INFO - 2016-02-25 17:25:37,872 DEBUG : Generating results file: kraken 17:25:37 INFO - 2016-02-25 17:25:37,872 INFO : javascript benchmark 17:25:37 INFO - 2016-02-25 17:25:37,872 DEBUG : Working with test: v8_7 17:25:37 INFO - 2016-02-25 17:25:37,873 DEBUG : Generating results file: v8_7 17:25:37 INFO - 2016-02-25 17:25:37,873 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:25:37 INFO - 2016-02-25 17:25:37,936 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,53,35]] 17:25:37 INFO - 2016-02-25 17:25:37,936 DEBUG : process_Request line: dromaeo_css 7299.96 graph.html#tests=[[72,53,35]] 17:25:37 INFO - 2016-02-25 17:25:37,936 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:25:37 INFO - 2016-02-25 17:25:37,983 DEBUG : process_Request line: kraken 1474.10 graph.html#tests=[[232,53,35]] 17:25:37 INFO - 2016-02-25 17:25:37,983 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:25:38 INFO - 2016-02-25 17:25:38,019 DEBUG : process_Request line: v8_7 23230.62 graph.html#tests=[[230,53,35]] 17:25:38 INFO - 2016-02-25 17:25:38,020 INFO : javascript benchmark 17:25:38 INFO - 2016-02-25 17:25:38,024 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3220.066180807565, 3304.1739565108724, 3327.8169700666467, 3329.0179397077845, 3359.7480188985833, 5333.973330133349, 5439.619226654131, 5445.428230035848, 5478.643888147278, 5490.286262785842, 5431.21247419124, 5464.0711079116545, 5475.67145971242, 5477.370102438221, 5504.532114770239, 4822.4213094428715, 4970.999999999991, 5056.84829455117, 5082.720450375228, 5120.718360490171, 4903.436104847952, 4959.404871415435, 5027.09512287788, 5031.371078615173, 5031.597472202233, 4992.975035124819, 5023.748812559375, 5061.974690126544, 5081.441041485434, 5088.771005304751, 5067.873303167414, 5116.948830511685, 5122.538971492546, 5134.820281290155, 5161.148410512298, 4825.517448255181, 4856.344393506866, 5038.042771873333, 5047.520485553867, 5101.056304583627, 5145.691258524501, 5234.26720259164, 5245.134552798783, 5246.554042906358, 5256.816011439581, 5865.76536938522, 5885.352611212763, 5933.22868027158, 5933.703314834241, 5934.347221805598, 5636.098224284095, 5768.682722450264, 5838.065909454467, 5949.940500595025, 5962.97018514909, 5563.610547261694, 5612.579056570733, 5615.185798059259, 5616.297962754615, 5616.466435688603, 6058.27300723916, 6062.545309101835, 6068.393160683896, 6068.423499767515, 6074.726637301332, 5618.157276408571, 5731.398203188689, 5781.4507621775865, 5901.439363260569, 5902.822915312548, 5967.791127310524, 5970.522358211333, 5970.641761494324, 5972.104184372379, 6007.15899774032, 5870.0607902735355, 5921.911171332434, 5925.4370834770625, 5934.673592952429, 5937.346891841894, 5658.292713410824, 5724.942750572524, 5865.4134586541, 5938.435848594377, 5949.464548190684, 4484.304932735366, 4497.460304763384, 4521.773911304422, 4524.411826462539, 4547.295169248771, 4080.9183816323507, 4082.1223436961195, 4085.0, 4086.244044851712, 4113.382992551082, 5396.622236443412, 5493.752781124859, 5521.1442226454965, 5623.887522249532, 5653.095504719307, 5873.089671100986, 5894.823155305347, 5910.704464776744, 5913.852153696192, 5919.3192782829665, 5574.916376254359, 5604.523615492647, 5612.130119831432, 5612.635178713371, 5612.7754889803955, 4921.803127874917, 5017.523335283142, 5032.194848824171, 5107.565856902131, 5146.228065790161, 6085.817425477243, 6091.939080609137, 6094.8171554853425, 6102.023676211874, 6102.420270074336, 5653.406392328746, 5912.940870591239, 5919.852003699856, 5930.169776231417, 5930.7627694893445, 5911.1428842816695, 5987.760489580368, 6091.116788065794, 6093.451589356979, 6126.326104128453, 5743.4256574342235, 5782.537397008314, 5795.043817770189, 5805.76776928935, 5810.215620891126, 5682.488576028178, 5802.912956305574, 5876.911846322223, 5883.411658834082, 5898.233229680286, 5656.406077361818, 5736.4550367715, 5739.139129130664, 5739.598228123991, 5778.393268706725, 5740.425957404226, 5778.971105144447, 5780.075187969905, 5782.045962416154, 5787.045137552425, 5402.972985135049, 5525.0883604204855, 5545.279113715191, 5673.035583950821, 5692.117721753135, 5714.942850571441, 5734.541236701138, 5744.396838331915, 5746.367899530965, 5783.219265399117, 5633.915491267552, 5663.0, 5667.4615911488345, 5671.234383358359, 5672.404397538199], "unit": "ms", "name": "dojo.html", "value": 5425.442550487489}, {"lowerIsBetter": false, "replicates": [549.4718856787823, 586.9354371019188, 593.1429084972216, 593.6200831467864, 603.9879202415949, 31343.0, 41935.0, 42408.363874541865, 42429.15141697172, 42521.149577008444, 46361.53638463614, 47180.52819471804, 47196.2920556192, 47246.291305630446, 47271.0, 7710.383169346467, 7826.0, 8939.642414303436, 9205.953970230139, 9237.445753254826, 10722.303050301745, 10934.890651093507, 10936.0, 10949.069329107035, 10949.397783121925, 10793.946030269877, 10926.235163538555, 10928.508217130247, 10932.781344373108, 10941.0, 7932.444728868982, 8134.227248411392, 10688.786224275509, 10776.40729759863, 11060.17048721349, 10624.09695175911, 10708.25042247043, 10711.089557387631, 10732.248742588023, 10774.622888198954, 42841.0, 43335.13329733388, 43350.132997340195, 43382.56617433817, 43392.56607433917, 3331.916702082443, 3384.1877949291993, 3484.3205574912904, 3847.2882516734494, 4156.293430116887, 32279.6772032279, 32500.0, 32527.674723252938, 32689.182770430692, 32704.182395440068, 4222.0, 4352.281873490871, 4388.451443569554, 4397.120575884804, 4404.229259879508, 306177.0, 306603.0, 307322.0, 307854.0, 309552.45223773964, 64284.35715642784, 64679.0, 64709.0, 64764.676176618814, 64834.0, 57099.145042747696, 58303.4169658298, 67727.66136169288, 68226.0, 68791.3120868795, 16799.2440340185, 17011.06439145834, 17019.574510637085, 17073.317067317417, 17082.145892705314, 13079.215247085014, 13156.60530184096, 13163.144395614254, 13163.868361316456, 13169.078164528391, 20627.484312891997, 20725.89637051805, 20990.580188396147, 21030.47423814417, 21032.0, 7805.180456052033, 7942.324902383247, 7963.1638677939145, 8015.0, 8066.475679080841, 943.9056094390506, 1025.8153532364247, 1083.285031878956, 1100.4772732951944, 1101.2731597145846, 29535.85232073826, 29584.852075739484, 29998.550021749692, 30519.389612207633, 30972.0, 1105.38098664748, 1113.3264375053138, 1197.934113623759, 1203.9458224379923, 1283.3454937981696, 13360.532381366605, 15554.22228888551, 15963.680726385408, 16059.357625694842, 16112.355505779638, 409216.0, 412768.0, 413190.0, 414953.0, 417048.0, 48235.75882120637, 62000.37999620036, 62780.68609657014, 62782.372176278564, 62936.0, 1340.3968214303602, 1400.2998500749625, 1490.5304828978838, 1491.963085655459, 1500.534834201401, 31711.682883171798, 31798.364032719677, 31956.20109497281, 32471.837640811646, 32712.83643581862, 46972.7651361741, 47491.52508474871, 47516.52483475121, 47556.7622161887, 47704.76147619379, 220956.0, 221799.0, 223910.0, 228393.0, 245008.0, 34994.82502587471, 36052.819735901154, 36176.0, 36229.818850905576, 36405.08987275339, 46300.07399851917, 46869.53130468652, 47310.0, 47833.52166478291, 48097.5190248107, 39443.211135777696, 39872.80063599663, 40527.143629768645, 41056.0, 41152.794236028625, 40079.39880901847, 40307.0, 40679.38980915348, 40909.79545102375, 41108.0, 39231.6076839228, 39562.80218598888, 39762.801185993885, 39766.60233397629, 39789.0, 34599.481007785405, 35493.0, 35607.287854242255, 36017.63982360143, 36073.81963090168, 26535.867320663274, 27134.864325678245, 27382.315442114108, 27390.178294651192, 27418.862905685342], "unit": "ms", "name": "ext.html", "value": 20180.23114899722}, {"lowerIsBetter": false, "replicates": [371.4407730735235, 374.18801201392984, 374.77700768043013, 375.57184809317386, 377.3905143193743, 17329.046902420378, 18272.634547309062, 18427.75984956931, 18566.90716546419, 19779.0, 18121.63756724868, 18424.447266582025, 18607.906960465214, 18720.344787932427, 18774.436766897015, 4206.705530612859, 4315.913681726363, 5000.174971129768, 5607.383187849333, 5609.523190528789, 4277.101808620194, 5923.200367950315, 6169.475594574466, 6185.103160041791, 6190.566660333779, 5996.730147143389, 6087.117367981662, 6178.9691051544905, 6184.56708030438, 6185.041318595625, 4203.180379825951, 4309.547497512747, 5970.552208584373, 6075.817725468243, 6090.086487026959, 5443.618946673734, 5447.618666693333, 5461.781528738846, 5461.9453805462235, 5468.343798744176, 20682.79317206839, 21953.451163721034, 22461.77538224613, 22473.55052898933, 22611.77388226113, 2413.505231427553, 2415.130553000918, 2481.937951551208, 2513.924582262535, 2671.559192733216, 14358.0, 14421.134731916118, 14446.783298250535, 14769.33537990793, 14824.258787060711, 1981.28673677476, 1990.0646696052977, 2007.7389939307795, 2047.764507081675, 2051.917923283067, 63982.360176398106, 65065.0, 65647.67176164089, 66828.3317166827, 67451.325486745, 10507.0, 10687.572497100029, 10740.248182627141, 10800.51397687106, 10888.183386246063, 14189.929050354682, 14242.07426517273, 14253.144811311355, 14271.429142834379, 14286.142831430148, 8302.958485207535, 8398.412111152284, 8588.098249683693, 8622.827543449095, 8638.654453821777, 8537.530435825965, 8552.657893684307, 8566.571671416405, 8627.525486098199, 8628.137186281321, 6385.680715964276, 6466.0, 6468.5472016958365, 6483.2544257411, 6483.870322593521, 1738.8608911287067, 1785.366195000782, 1812.5196822841958, 1839.2275244397385, 1869.205587625281, 942.9717108486757, 974.7368210583103, 1016.6848277034143, 1022.7187523431116, 1044.7335929337971, 16882.240299186567, 17076.914615426842, 17199.312027518758, 17334.219960101826, 17690.292388304322, 876.4741155306892, 970.3013830042358, 982.597135174575, 989.0455710239653, 1029.953652085658, 9384.390014649163, 9930.801383972424, 10261.7434564135, 10293.74265643365, 10364.170866330825, 626209.0, 633769.0, 637241.0, 653177.0, 654606.0, 84606.0, 86493.56753216193, 87275.56362218148, 87605.56197218974, 88703.11296887077, 1245.1470742541387, 1246.3456685240321, 1249.8187762774346, 1251.9874801252054, 1265.3926115464628, 15115.697686046438, 15676.529704108894, 15865.68268634644, 16275.593110171867, 16369.67260654804, 32810.50784238191, 32932.50601241031, 32998.0, 33522.497162542095, 34120.1469963243, 38747.80626096964, 40322.79838600788, 40741.38887916625, 41666.0, 44664.33003505015, 9705.932347441634, 9762.658306959222, 9911.702648920544, 9919.801603968024, 9929.056739609725, 18110.63778724392, 18432.631347373244, 18519.166637501614, 18770.0, 18997.525061873563, 14921.701565968402, 15460.226988650747, 15726.0, 15736.0, 15975.360985560912, 15105.54683359501, 15113.0, 15184.924075379553, 15680.0, 15846.762298565762, 15411.306491207699, 15725.213739313218, 15755.684886302439, 15934.0, 16262.837371626132, 9516.95241523788, 9677.612895484102, 9696.466694331879, 9790.26573007013, 9850.310478266452, 10133.341332813343, 12114.515419383126, 15130.773038404213, 15451.61370965735, 15526.611834704223], "unit": "ms", "name": "jquery.html", "value": 9578.841442305515}, {"lowerIsBetter": false, "replicates": [1554.2228885557222, 1555.9377624894998, 1751.632157246978, 1775.3076300242903, 1830.8993005384698, 7883.448158628898, 8280.62737176827, 8288.502689838613, 8292.419530632858, 8294.875576866345, 8034.758957231278, 8108.148644392328, 8129.512229266248, 8135.75592732219, 8137.18628137186, 2232.10715713715, 2235.2176738141684, 2268.6710426988075, 2271.205078222625, 2271.5570463759573, 2303.424143964009, 2334.1830359374167, 2335.0, 2335.6730057791838, 2337.520808234308, 1914.473519782057, 1956.8630195886294, 1957.0997341223053, 2216.556688662266, 2303.665968434576, 2200.449887528118, 2255.3008567344095, 2256.1088370093885, 2258.1193334599357, 2258.2660635293596, 2263.388885001057, 2264.4338915271182, 2294.357579877637, 2296.01271453275, 2325.686032385623, 6683.331666833278, 6902.102726645504, 7743.264389882952, 8092.028956525196, 8193.0, 4719.9292010619865, 4815.036992601459, 4815.831445899412, 4851.223804191348, 4855.927161092586, 2980.1059682095283, 3003.9249018774485, 3036.3927214556957, 3040.5743195952364, 3059.2351912021995, 933.9626414943394, 936.180841763457, 946.5361972633428, 967.4485543240356, 979.0405402705388, 11042.282251653616, 11078.058365038982, 11102.444877756161, 11106.500207490602, 11109.277896936754, 4179.728317659403, 4183.205191013698, 4241.936370954438, 4242.469691288589, 4251.383549385322, 9638.325317227867, 9649.421034737938, 9659.758506037406, 9670.516474176404, 9685.854712179182, 4639.605633521121, 4669.696469729457, 4676.111538807616, 4677.672562920563, 4682.9765851171205, 4203.096334288142, 4204.516480604709, 4206.074663574009, 4210.263203939298, 4210.494740631144, 3509.7192224621967, 3576.8390422431053, 3597.7481576289933, 3598.3163198992106, 3599.154198763341, 1021.4024795494719, 1042.4996001919121, 1045.095991966943, 1061.580675633136, 1065.4672663668166, 1393.644620621735, 1414.70291238841, 1450.2386247220084, 1459.737247295497, 1465.8314293856342, 7559.773206803805, 7583.431242656823, 7611.543307401574, 7650.1202361728, 7652.80867978305, 447.84363290754914, 453.36302494994584, 454.79988804926387, 456.5252137776675, 456.99314510282375, 5193.532582067632, 5856.033754430471, 5896.793612223637, 5907.734151963172, 5907.966105931445, 8682.262007729414, 9322.0, 9498.050194980586, 9573.32986690925, 9589.136977672042, 9325.393849399767, 9389.577469013911, 9441.952790236142, 9476.431414115175, 9723.124918757205, 7661.463697541119, 7668.463207575416, 7679.1936846631415, 7696.807579810549, 7738.110117336466, 7390.076240469942, 7408.518446300973, 7468.701251949861, 7484.925150748423, 7522.398208143445, 8561.957190214009, 8641.222289993932, 8739.868901966604, 8769.166929141722, 8815.867761983447, 8913.509756963429, 8922.73231803047, 9013.954930225307, 9040.819183616422, 9042.140996605312, 7191.604461754654, 7296.635168241461, 7394.075740532434, 7403.7408690695565, 7407.074115735533, 7812.453128280966, 7917.327027202752, 7952.244536768998, 7966.322862556747, 7974.40191985615, 7402.259774022555, 7431.554106753612, 7489.325960663567, 7494.325510704063, 7511.136219334628, 7381.889271660822, 7395.482316237812, 7401.0748656417945, 7479.588622625808, 7481.551106933602, 7143.2499587544635, 7150.177729561167, 7197.100362454693, 7217.0, 7291.635418229173, 6636.0377745225705, 6645.169353830771, 6648.867022659423, 6661.467082633475, 6664.200295964515, 6698.162729658793, 6725.29384414649, 6812.829679258059, 6815.69329380189, 6835.658217089026], "unit": "ms", "name": "mootools.html", "value": 4471.01637484678}, {"lowerIsBetter": false, "replicates": [345.72514850693693, 346.9514268002479, 348.1574589493426, 348.9546358973334, 356.71641045368926, 6072.058830881209, 6113.602615829968, 6140.631562106266, 6148.231471066117, 6218.689065546727, 6052.364501727321, 6065.514758819295, 6066.120412540179, 6073.119397687333, 6079.7264123114455, 4642.419697537808, 4655.4878963314, 4703.670743047996, 4721.433427988646, 4723.622110231173, 4712.787924543387, 4725.480197178307, 4726.527347265281, 4727.952720472786, 4734.881627959294, 4675.672702910781, 4677.041206552649, 4678.0, 4689.179393606105, 4689.5310468953, 4481.551844815509, 4550.863474095782, 4579.152856721484, 4686.695364801294, 4720.716756994557, 4144.316187829005, 4161.97919010403, 4173.436586060873, 4180.352045432963, 4183.079722461053, 5661.179129026309, 5847.590668653196, 5857.384974577651, 5859.2382990211, 5862.853428664275, 5357.7589008494715, 5392.379876314196, 5516.972415137939, 5520.282363292747, 5521.861953451155, 6425.8393540161405, 6445.806625801233, 6451.870962580769, 6459.192600924885, 6459.870802583969, 4622.838200662961, 4624.144533261324, 4626.653001024903, 4629.606483448911, 4629.861104166846, 6629.502787290972, 6702.798916032527, 6718.0, 6725.226598941135, 6729.966350168267, 4744.430668319824, 4755.500672429345, 4758.191107511731, 4759.048190361872, 4763.928541071887, 4776.379070720854, 4784.617230621542, 4787.234042553245, 4789.688670236424, 4793.904121917542, 5269.657472264291, 5478.616496845262, 5483.616146869761, 5492.176173573996, 5495.450454954473, 6556.114924485133, 6564.113844631009, 6564.277929427759, 6573.901391479131, 6576.0, 1632.9755053674205, 1644.3587001069354, 1645.3336398758522, 1645.6790925769599, 1646.1604581663437, 1114.5876025870318, 1118.2619471149003, 1119.6193294279822, 1130.1072152999202, 1140.863096428434, 6426.132472116298, 6427.132337134521, 6428.871422571522, 6436.098946147543, 6439.259485159173, 6788.694508747119, 6790.388865002074, 6800.217974932847, 6800.353966373186, 6801.0, 6307.211598550181, 6418.679066046679, 6428.935710642833, 6430.871382572416, 6434.64609446485, 3647.0335361129323, 3676.411774116182, 3680.411134218512, 3682.705383569308, 3683.1896982664307, 7046.330598593126, 7048.506604537735, 7053.224145344008, 7057.4001209896705, 7061.1173603299585, 6531.11829902957, 6729.663516824139, 6866.249106477816, 6877.4841886857685, 7000.719971201095, 6909.930900691029, 7027.683754231072, 7065.999999999897, 7068.11648543932, 7074.504784665127, 6838.487113466609, 6838.760643377458, 6839.897401538881, 6847.383735463832, 6854.897176542256, 6575.408213260829, 6718.462522998246, 6720.227173874871, 6720.865582688417, 6723.294054124247, 6907.033015377951, 7033.366996970297, 7038.507304488841, 7044.049053377933, 7045.859082818418, 4632.328312394617, 4673.135469938073, 4673.345731597511, 4675.4856965734425, 4683.203855344667, 6670.631925666318, 6795.422389096784, 6804.897926531007, 6812.352826481477, 6813.148356455443, 6601.0, 6639.502037347315, 6640.634765087966, 6642.103316052271, 6648.601083934979, 6578.473722102316, 6610.933890661032, 6625.966870165618, 6631.602103873783, 6631.867362652816, 6406.327335629878, 6496.577722448026, 6526.053722210158, 6533.477321814148, 6535.705893234721, 6599.637019963756, 6662.500312476681, 6666.733330666719, 6669.866602667822, 6675.198976122896, 6508.15393998796, 6510.121133647087, 6522.380373864476, 6523.054157147282, 6529.444997175293], "unit": "ms", "name": "prototype.html", "value": 4959.068773053167}, {"lowerIsBetter": false, "replicates": [858.3862538285126, 918.3342076994185, 927.5733162745137, 931.3573634192411, 942.6559305853364, 12549.68625784356, 12755.617331480058, 12827.0, 12850.164739291962, 12868.67828304293, 11562.13284003699, 12792.296423696693, 12904.032197585171, 12905.2902090385, 12930.547430839899, 707.1231672725809, 877.2411863737852, 890.6392910871075, 891.1044400377612, 892.1702816380763, 900.9144131307515, 901.8602116671926, 906.4742449379344, 909.9454032758056, 910.1762904571374, 741.1550832051465, 750.3284560318511, 945.5886689290146, 949.1220620925651, 949.2263804998904, 922.3681777982071, 932.072587775168, 932.1563984593953, 932.9580168892417, 934.9298802589799, 703.2159142556064, 703.3669697272445, 703.4231929817552, 703.9753608623673, 705.8764716174649, 13157.802632960513, 13292.800607990888, 13317.13438626496, 13353.86646133536, 13354.0, 11626.360550169737, 11882.643520694393, 11954.701132471671, 12094.09294302922, 12117.454714537867, 10417.166626669848, 10616.62841800541, 10685.893141068567, 10740.946295268473, 10780.62461946921, 3835.8657446989223, 3867.091233560111, 3880.398538226551, 3904.1801221743185, 3904.8047597620007, 43706.0, 43790.56209437897, 46489.53510464886, 47278.29082563764, 47357.052858942625, 9890.279095410953, 10209.744756381002, 10250.077493025663, 10276.959222682424, 10457.477126143815, 18150.273989040554, 18301.176447059916, 18311.54221144482, 18383.81616183821, 18387.172577234058, 7486.85026299471, 7598.164201937893, 7678.884816727754, 7687.769366918889, 7970.6413211405625, 4363.650907927358, 4379.934300985487, 4419.801108950105, 4447.688661793643, 4469.5530446955045, 3139.434901717667, 3172.5241213818113, 3172.682731726809, 3176.6029246344206, 3176.857041433141, 546.4098773324799, 553.139867506024, 560.680412165062, 561.3348182403864, 562.6174201542908, 689.7137687859482, 696.373264062348, 717.519262094398, 726.0, 737.310614575363, 8070.47541909774, 8072.071711753224, 8081.151479094728, 8265.256126948603, 8416.676588482716, 573.1774903014187, 605.3129697793037, 652.0154566604461, 719.133444199738, 721.7618185998608, 3881.4177873319227, 4146.274401979642, 4147.336426171798, 4167.541570427251, 4255.276602977501, 55608.0, 65145.0, 65579.0, 66223.0, 66603.33396666068, 50856.0, 51978.101642376976, 52559.73720131375, 53021.0, 53374.73312633412, 47768.0, 47896.521034789206, 48080.27879581809, 48165.5183448168, 49665.99999999928, 8547.700830470903, 8936.553172341228, 8983.281337493116, 8993.820123597361, 9127.13292237263, 35154.296914062084, 36155.457668135525, 36333.45499817558, 36339.818300909385, 36388.81805591061, 43656.78171609122, 44703.32945005762, 45840.312395314766, 46127.0, 46522.534774651824, 11195.328280303207, 11365.090792736395, 11546.59586914454, 11668.591599293984, 11692.123090768056, 12573.434195461408, 12600.369981501071, 12756.936215318863, 13147.934260328637, 13404.865951340362, 10835.67492975212, 11337.319760814047, 11762.176647634584, 11806.586769463027, 11808.468618912342, 11548.826767598324, 11623.360715160747, 11629.88370116288, 11735.41322933867, 11773.293602383885, 10479.941590467748, 10948.124150068135, 11044.061254793432, 11067.446627668423, 11395.373254471084, 10449.216308777024, 10557.683269501927, 10662.0, 10803.243772935819, 11060.22578419535, 9833.901660983298, 10084.798304033731, 10138.138258248131, 10147.543360548645, 10222.284440089123], "unit": "ms", "name": "yui.html", "value": 6507.290508073738}], "name": "dromaeo_css", "value": 7299.9582804619395}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 111.0, 104.0, 108.0, 109.0, 110.0, 99.0, 108.0, 108.0, 116.0], "unit": "ms", "name": "ai-astar", "value": 108.2}, {"lowerIsBetter": true, "replicates": [154.0, 126.0, 146.0, 154.0, 122.0, 148.0, 146.0, 129.0, 170.0, 123.0], "unit": "ms", "name": "audio-beat-detection", "value": 141.8}, {"lowerIsBetter": true, "replicates": [160.0, 159.0, 160.0, 161.0, 160.0, 160.0, 159.0, 161.0, 160.0, 160.0], "unit": "ms", "name": "audio-dft", "value": 160.0}, {"lowerIsBetter": true, "replicates": [70.0, 75.0, 73.0, 147.0, 72.0, 71.0, 72.0, 80.0, 153.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 88.4}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 144.0, 92.0, 93.0, 93.0, 136.0, 93.0, 93.0, 136.0], "unit": "ms", "name": "audio-oscillator", "value": 106.6}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 109.0, 109.0, 110.0, 109.0, 110.0, 109.0, 109.0, 108.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 146.0, 145.0, 145.0, 146.0, 145.0, 146.0, 145.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.4}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 96.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.3}, {"lowerIsBetter": true, "replicates": [56.0, 56.0, 58.0, 55.0, 56.0, 56.0, 58.0, 58.0, 54.0, 54.0], "unit": "ms", "name": "json-parse-financial", "value": 56.1}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 63.0, 64.0, 65.0, 65.0, 64.0, 64.0, 64.0, 64.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 64.1}, {"lowerIsBetter": true, "replicates": [76.0, 78.0, 78.0, 79.0, 79.0, 80.0, 78.0, 80.0, 80.0, 87.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 79.5}, {"lowerIsBetter": true, "replicates": [120.0, 113.0, 118.0, 117.0, 122.0, 113.0, 119.0, 120.0, 110.0, 111.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 116.3}, {"lowerIsBetter": true, "replicates": [131.0, 150.0, 145.0, 140.0, 142.0, 131.0, 135.0, 142.0, 141.0, 131.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 138.8}, {"lowerIsBetter": true, "replicates": [64.0, 68.0, 66.0, 64.0, 63.0, 63.0, 63.0, 64.0, 63.0, 65.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 64.3}], "name": "kraken", "value": 1474.0999999999997}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.81339150864238], "unit": "score", "name": "Richards", "value": 210.36461799999995}, {"lowerIsBetter": false, "replicates": [164.50074025333114], "unit": "score", "name": "DeltaBlue", "value": 401.93132199999985}, {"lowerIsBetter": false, "replicates": [278.9400278940028], "unit": "score", "name": "Encrypt", "value": 954.2588850000001}, {"lowerIsBetter": false, "replicates": [5191.709844559586], "unit": "score", "name": "Decrypt", "value": 51.270392215568904}, {"lowerIsBetter": false, "replicates": [942.5070688030161], "unit": "score", "name": "RayTrace", "value": 785.1283289999999}, {"lowerIsBetter": false, "replicates": [540.5405405405405], "unit": "score", "name": "Earley", "value": 1232.95655}, {"lowerIsBetter": false, "replicates": [10891.304347826086], "unit": "score", "name": "Boyer", "value": 61.19221157684634}, {"lowerIsBetter": false, "replicates": [24333.333333333332], "unit": "score", "name": "RegExp", "value": 37.437739726027424}, {"lowerIsBetter": false, "replicates": [521.1047420531527], "unit": "score", "name": "Splay", "value": 156.38122899999993}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 23230.622722808897}]} 17:25:38 INFO - RETURN: dromaeo_css: 7299.96 17:25:38 INFO - RETURN: kraken: 1474.10 17:25:38 INFO - RETURN: v8_7: 23230.62 17:25:38 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,53,35]]", "result": "23230.62"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,53,35]]", "result": "1474.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,53,35]]", "result": "7299.96"}}} 17:25:38 INFO - Return code: 0 17:25:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 17:25:38 INFO - # TBPL SUCCESS # 17:25:38 INFO - Running post-action listener: _resource_record_post_action 17:25:38 INFO - Running post-run listener: _resource_record_post_run 17:25:39 INFO - Total resource usage - Wall time: 1226s; CPU: 13.0%; Read bytes: 323584; Write bytes: 514105344; Read time: 200; Write time: 881164 17:25:39 INFO - install - Wall time: 15s; CPU: 16.0%; Read bytes: 0; Write bytes: 253407232; Read time: 0; Write time: 582504 17:25:39 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 323584; Write bytes: 260100096; Read time: 200; Write time: 298660 17:25:39 INFO - Running post-run listener: _upload_blobber_files 17:25:39 INFO - Blob upload gear active. 17:25:39 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 17:25:39 INFO - Copying logs to upload dir... 17:25:39 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1259.266249 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2016-02-25 17:25:38.558776) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-02-25 17:25:38.561994) ========= 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=1861a34ebfea852630dec091000001fa-1456447534.865157-1401355038 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456435168/firefox-45.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010127 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456435168/firefox-45.0.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2016-02-25 17:25:38.612573) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 17:25:38.612909) ========= 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=1861a34ebfea852630dec091000001fa-1456447534.865157-1401355038 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004497 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 17:25:38.662169) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-25 17:25:38.662472) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-25 17:25:38.662746) ========= ========= Total master_lag: 0.27 =========