builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-034 starttime: 1455625697.43 results: success (0) buildid: 20160216020950 builduid: a573cd3f09e941919cb7024d34acb2ba revision: b454ec296bf6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-16 04:28:17.428243) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-16 04:28:17.428721) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-16 04:28:17.429012) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1455625270.900196-363091807 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006399 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-16 04:28:17.451922) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-16 04:28:17.452183) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-16 04:28:17.465085) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-16 04:28:17.465362) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1455625270.900196-363091807 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004569 ========= master_lag: 0.17 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-16 04:28:17.641099) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-16 04:28:17.641392) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-16 04:28:17.641742) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-16 04:28:17.642023) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1455625270.900196-363091807 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-16 04:28:18-- 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% 34.0M=0s 2016-02-16 04:28:18 (34.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.166275 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-16 04:28:17.820343) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-16 04:28:17.820638) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1455625270.900196-363091807 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016178 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-16 04:28:17.872170) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-16 04:28:17.872476) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev b454ec296bf6 --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 b454ec296bf6 --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=d6bbd613908ccac0c6c9cb47000001f7-1455625270.900196-363091807 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-16 04:28:18,814 Setting DEBUG logging. 2016-02-16 04:28:18,814 attempt 1/10 2016-02-16 04:28:18,814 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/b454ec296bf6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-16 04:28:19,091 unpacking tar archive at: mozilla-beta-b454ec296bf6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.597629 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-16 04:28:18.485661) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-16 04:28:18.489025) ========= echo b454ec296bf6 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'b454ec296bf6'] 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=d6bbd613908ccac0c6c9cb47000001f7-1455625270.900196-363091807 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False b454ec296bf6 program finished with exit code 0 elapsedTime=0.004024 script_repo_revision: 'b454ec296bf6' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-16 04:28:18.541303) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-16 04:28:18.541612) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-16 04:28:18.553317) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-02-16 04:28:18.553600) ========= /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=d6bbd613908ccac0c6c9cb47000001f7-1455625270.900196-363091807 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:28:19 INFO - MultiFileLogger online at 20160216 04:28:19 in /builds/slave/test-pgo 04:28:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 04:28:19 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 04:28:19 INFO - {'append_to_log': False, 04:28:19 INFO - 'base_work_dir': '/builds/slave/test-pgo', 04:28:19 INFO - 'blob_upload_branch': 'Mozilla-Beta', 04:28:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 04:28:19 INFO - 'branch': 'Mozilla-Beta', 04:28:19 INFO - 'buildbot_json_path': 'buildprops.json', 04:28:19 INFO - 'config_files': ('talos/linux_config.py',), 04:28:19 INFO - 'default_actions': ('clobber', 04:28:19 INFO - 'read-buildbot-config', 04:28:19 INFO - 'download-and-extract', 04:28:19 INFO - 'populate-webroot', 04:28:19 INFO - 'create-virtualenv', 04:28:19 INFO - 'install', 04:28:19 INFO - 'run-tests'), 04:28:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:28:19 INFO - 'download_minidump_stackwalk': True, 04:28:19 INFO - 'download_symbols': 'ondemand', 04:28:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:28:19 INFO - 'tooltool.py': '/tools/tooltool.py', 04:28:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:28:19 INFO - '/tools/misc-python/virtualenv.py')}, 04:28:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:28:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:28:19 INFO - 'installer_path': 'installer.exe', 04:28:19 INFO - 'log_level': 'info', 04:28:19 INFO - 'log_name': 'talos', 04:28:19 INFO - 'log_to_console': True, 04:28:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:28:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:28:19 INFO - 'opt_config_files': (), 04:28:19 INFO - 'pip_index': False, 04:28:19 INFO - 'sps_profile': False, 04:28:19 INFO - 'sps_profile_interval': 0, 04:28:19 INFO - 'suite': 'dromaeojs', 04:28:19 INFO - 'system_bits': '32', 04:28:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:28:19 INFO - 'title': 'talos-linux64-ix-034', 04:28:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:28:19 INFO - 'use_talos_json': True, 04:28:19 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 04:28:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:28:19 INFO - 'work_dir': 'build'} 04:28:19 INFO - ##### 04:28:19 INFO - ##### Running clobber step. 04:28:19 INFO - ##### 04:28:19 INFO - Running pre-action listener: _resource_record_pre_action 04:28:19 INFO - Running main action method: clobber 04:28:19 INFO - rmtree: /builds/slave/test-pgo/build 04:28:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 04:28:20 INFO - Running post-action listener: _resource_record_post_action 04:28:20 INFO - ##### 04:28:20 INFO - ##### Running read-buildbot-config step. 04:28:20 INFO - ##### 04:28:20 INFO - Running pre-action listener: _resource_record_pre_action 04:28:20 INFO - Running main action method: read_buildbot_config 04:28:20 INFO - Using buildbot properties: 04:28:20 INFO - { 04:28:20 INFO - "properties": { 04:28:20 INFO - "buildnumber": 108, 04:28:20 INFO - "product": "firefox", 04:28:20 INFO - "script_repo_revision": "production", 04:28:20 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 04:28:20 INFO - "repository": "", 04:28:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 04:28:20 INFO - "buildid": "20160216020950", 04:28:20 INFO - "slavename": "talos-linux64-ix-034", 04:28:20 INFO - "pgo_build": "True", 04:28:20 INFO - "basedir": "/builds/slave/test-pgo", 04:28:20 INFO - "project": "", 04:28:20 INFO - "platform": "ubuntu64_hw", 04:28:20 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:28:20 INFO - "slavebuilddir": "test", 04:28:20 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 04:28:20 INFO - "branch": "mozilla-beta", 04:28:20 INFO - "repo_path": "releases/mozilla-beta", 04:28:20 INFO - "stage_platform": "linux64-pgo", 04:28:20 INFO - "builduid": "a573cd3f09e941919cb7024d34acb2ba", 04:28:20 INFO - "revision": "b454ec296bf6" 04:28:20 INFO - }, 04:28:20 INFO - "sourcestamp": { 04:28:20 INFO - "repository": "", 04:28:20 INFO - "hasPatch": false, 04:28:20 INFO - "project": "", 04:28:20 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 04:28:20 INFO - "changes": [ 04:28:20 INFO - { 04:28:20 INFO - "category": null, 04:28:20 INFO - "files": [ 04:28:20 INFO - { 04:28:20 INFO - "url": null, 04:28:20 INFO - "name": "http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455617390/firefox-45.0.en-US.linux-x86_64.tar.bz2" 04:28:20 INFO - } 04:28:20 INFO - ], 04:28:20 INFO - "repository": "", 04:28:20 INFO - "rev": "b454ec296bf6", 04:28:20 INFO - "who": "sendchange", 04:28:20 INFO - "when": 1455625672, 04:28:20 INFO - "number": 7609337, 04:28:20 INFO - "comments": "Backed out 12 changesets (bug 1246592, bug 1239828, bug 1154277, bug 1245912, bug 1229195) for causing closed beta tree due to bustage on windows on a CLOSED TREE", 04:28:20 INFO - "project": "", 04:28:20 INFO - "at": "Tue 16 Feb 2016 04:27:52", 04:28:20 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 04:28:20 INFO - "revlink": "", 04:28:20 INFO - "properties": [ 04:28:20 INFO - [ 04:28:20 INFO - "buildid", 04:28:20 INFO - "20160216020950", 04:28:20 INFO - "Change" 04:28:20 INFO - ], 04:28:20 INFO - [ 04:28:20 INFO - "builduid", 04:28:20 INFO - "a573cd3f09e941919cb7024d34acb2ba", 04:28:20 INFO - "Change" 04:28:20 INFO - ], 04:28:20 INFO - [ 04:28:20 INFO - "pgo_build", 04:28:20 INFO - "True", 04:28:20 INFO - "Change" 04:28:20 INFO - ] 04:28:20 INFO - ], 04:28:20 INFO - "revision": "b454ec296bf6" 04:28:20 INFO - } 04:28:20 INFO - ], 04:28:20 INFO - "revision": "b454ec296bf6" 04:28:20 INFO - } 04:28:20 INFO - } 04:28:20 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455617390/firefox-45.0.en-US.linux-x86_64.tar.bz2. 04:28:20 INFO - Running post-action listener: _resource_record_post_action 04:28:20 INFO - ##### 04:28:20 INFO - ##### Running download-and-extract step. 04:28:20 INFO - ##### 04:28:20 INFO - Running pre-action listener: _resource_record_pre_action 04:28:20 INFO - Running main action method: download_and_extract 04:28:20 INFO - mkdir: /builds/slave/test-pgo/build/tests 04:28:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:28:20 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455617390/test_packages.json 04:28:20 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455617390/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 04:28:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455617390/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 04:28:20 INFO - Downloaded 1270 bytes. 04:28:20 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 04:28:20 INFO - Using the following test package requirements: 04:28:20 INFO - {u'common': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 04:28:20 INFO - u'cppunittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 04:28:20 INFO - u'firefox-45.0.en-US.linux-x86_64.cppunittest.tests.zip'], 04:28:20 INFO - u'jittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 04:28:20 INFO - u'jsshell-linux-x86_64.zip'], 04:28:20 INFO - u'mochitest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 04:28:20 INFO - u'firefox-45.0.en-US.linux-x86_64.mochitest.tests.zip'], 04:28:20 INFO - u'mozbase': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 04:28:20 INFO - u'reftest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 04:28:20 INFO - u'firefox-45.0.en-US.linux-x86_64.reftest.tests.zip'], 04:28:20 INFO - u'talos': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 04:28:20 INFO - u'firefox-45.0.en-US.linux-x86_64.talos.tests.zip'], 04:28:20 INFO - u'web-platform': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 04:28:20 INFO - u'firefox-45.0.en-US.linux-x86_64.web-platform.tests.zip'], 04:28:20 INFO - u'webapprt': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 04:28:20 INFO - u'xpcshell': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 04:28:20 INFO - u'firefox-45.0.en-US.linux-x86_64.xpcshell.tests.zip']} 04:28:20 INFO - Downloading packages: [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:28:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:28:20 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455617390/firefox-45.0.en-US.linux-x86_64.common.tests.zip 04:28:20 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455617390/firefox-45.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 04:28:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455617390/firefox-45.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:28:20 INFO - Downloaded 21581412 bytes. 04:28:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 04:28:20 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 04:28:20 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 04:28:21 INFO - Return code: 0 04:28:21 INFO - Downloading packages: [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:28:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:28:21 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455617390/firefox-45.0.en-US.linux-x86_64.common.tests.zip 04:28:21 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455617390/firefox-45.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 04:28:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455617390/firefox-45.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:28:22 INFO - Downloaded 21581412 bytes. 04:28:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 04:28:22 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 04:28:22 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 04:28:23 INFO - Return code: 0 04:28:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:28:23 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455617390/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 04:28:23 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455617390/firefox-45.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 04:28:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455617390/firefox-45.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:28:25 INFO - Downloaded 11132038 bytes. 04:28:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 04:28:25 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 04:28:25 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 04:28:26 INFO - Return code: 0 04:28:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:28:26 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455617390/firefox-45.0.en-US.linux-x86_64.tar.bz2 04:28:26 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455617390/firefox-45.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.tar.bz2 04:28:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455617390/firefox-45.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:28:27 INFO - Downloaded 57946819 bytes. 04:28:27 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455617390/firefox-45.0.en-US.linux-x86_64.tar.bz2 04:28:27 INFO - mkdir: /builds/slave/test-pgo/properties 04:28:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 04:28:27 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 04:28:27 INFO - Contents: 04:28:27 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455617390/firefox-45.0.en-US.linux-x86_64.tar.bz2 04:28:27 INFO - Running post-action listener: _resource_record_post_action 04:28:27 INFO - Running post-action listener: set_extra_try_arguments 04:28:27 INFO - ##### 04:28:27 INFO - ##### Running populate-webroot step. 04:28:27 INFO - ##### 04:28:27 INFO - Running pre-action listener: _resource_record_pre_action 04:28:27 INFO - Running main action method: populate_webroot 04:28:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:28:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:28:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:28:27 INFO - '--tppagecycles', 04:28:27 INFO - '7'], 04:28:27 INFO - 'tests': ['tsvgm']}}, 04:28:27 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:28:27 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:28:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:28:27 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:28:27 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:28:27 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:28:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:28:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:28:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:28:27 INFO - 'talos_options': ['--e10s'], 04:28:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:28:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:28:27 INFO - 'tests': ['damp', 'tps']}, 04:28:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:28:27 INFO - 'talos_options': ['--e10s'], 04:28:27 INFO - 'tests': ['damp', 'tps']}, 04:28:27 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:28:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:28:27 INFO - 'other': {'tests': ['a11yr', 04:28:27 INFO - 'ts_paint', 04:28:27 INFO - 'tpaint', 04:28:27 INFO - 'sessionrestore', 04:28:27 INFO - 'sessionrestore_no_auto_restore']}, 04:28:27 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:28:27 INFO - 'tests': ['a11yr', 04:28:27 INFO - 'ts_paint', 04:28:27 INFO - 'tpaint', 04:28:27 INFO - 'sessionrestore', 04:28:27 INFO - 'sessionrestore_no_auto_restore']}, 04:28:27 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:28:27 INFO - 'tests': ['a11yr', 04:28:27 INFO - 'ts_paint', 04:28:27 INFO - 'tpaint', 04:28:27 INFO - 'sessionrestore', 04:28:27 INFO - 'sessionrestore_no_auto_restore']}, 04:28:27 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:28:27 INFO - 'tests': ['a11yr', 04:28:27 INFO - 'ts_paint', 04:28:27 INFO - 'tpaint', 04:28:27 INFO - 'sessionrestore', 04:28:27 INFO - 'sessionrestore_no_auto_restore']}, 04:28:27 INFO - 'other_l64': {'tests': ['a11yr', 04:28:27 INFO - 'ts_paint', 04:28:27 INFO - 'tpaint', 04:28:27 INFO - 'sessionrestore', 04:28:27 INFO - 'sessionrestore_no_auto_restore']}, 04:28:27 INFO - 'other_nol64': {'tests': ['a11yr', 04:28:27 INFO - 'ts_paint', 04:28:27 INFO - 'tpaint', 04:28:27 INFO - 'sessionrestore', 04:28:27 INFO - 'sessionrestore_no_auto_restore']}, 04:28:27 INFO - 'svgr': {'tests': ['tsvgx', 04:28:27 INFO - 'tsvgr_opacity', 04:28:27 INFO - 'tart', 04:28:27 INFO - 'tscrollx', 04:28:27 INFO - 'cart']}, 04:28:27 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:28:27 INFO - 'tests': ['tsvgx', 04:28:27 INFO - 'tsvgr_opacity', 04:28:27 INFO - 'tart', 04:28:27 INFO - 'tscrollx', 04:28:27 INFO - 'cart']}, 04:28:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:28:27 INFO - 'tests': ['tp5o']}, 04:28:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:28:27 INFO - 'talos_options': ['--e10s'], 04:28:27 INFO - 'tests': ['tp5o']}, 04:28:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:28:27 INFO - 'talos_options': ['--xperf_path', 04:28:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:28:27 INFO - 'tests': ['tp5n']}, 04:28:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:28:27 INFO - 'talos_options': ['--e10s', 04:28:27 INFO - '--xperf_path', 04:28:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:28:27 INFO - 'tests': ['tp5n']}}, 04:28:27 INFO - 'talos.zip': {'path': '', 04:28:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:28:27 INFO - Running post-action listener: _resource_record_post_action 04:28:27 INFO - ##### 04:28:27 INFO - ##### Running create-virtualenv step. 04:28:27 INFO - ##### 04:28:27 INFO - Running pre-action listener: _resource_record_pre_action 04:28:27 INFO - Running main action method: create_virtualenv 04:28:27 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 04:28:27 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 04:28:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 04:28:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:28:27 INFO - Using real prefix '/usr' 04:28:27 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 04:28:28 INFO - Installing distribute.............................................................................................................................................................................................done. 04:28:29 INFO - Installing pip.................done. 04:28:30 INFO - Return code: 0 04:28:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 04:28:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:28:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:28:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:28:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:28:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:28:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:28:30 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 0x7f4a82b3cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f6d600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffc350>, '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 0x1ffd250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ffd6e0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1455625270.900196-363091807', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:28:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 04:28:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:28:30 INFO - Using env: {'DISPLAY': ':0', 04:28:30 INFO - 'HOME': '/home/cltbld', 04:28:30 INFO - 'LANG': 'en_US.UTF-8', 04:28:30 INFO - 'LANGUAGE': 'en_US:en', 04:28:30 INFO - 'LOGNAME': 'cltbld', 04:28:30 INFO - 'MAIL': '/var/mail/cltbld', 04:28:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:28:30 INFO - 'MOZ_NO_REMOTE': '1', 04:28:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:28:30 INFO - 'NO_EM_RESTART': '1', 04:28:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:28:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:28:30 INFO - 'PWD': '/builds/slave/test-pgo', 04:28:30 INFO - 'SHELL': '/bin/bash', 04:28:30 INFO - 'SHLVL': '1', 04:28:30 INFO - 'TERM': 'linux', 04:28:30 INFO - 'TMOUT': '86400', 04:28:30 INFO - 'USER': 'cltbld', 04:28:30 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1455625270.900196-363091807', 04:28:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:28:30 INFO - '_': '/tools/buildbot/bin/python'} 04:28:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:28:30 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:28:30 INFO - Cleaning up... 04:28:30 INFO - Return code: 0 04:28:30 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 04:28:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:28:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:28:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:28:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:28:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:28:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:28:30 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 0x7f4a82b3cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f6d600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffc350>, '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 0x1ffd250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ffd6e0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1455625270.900196-363091807', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:28:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 04:28:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:28:30 INFO - Using env: {'DISPLAY': ':0', 04:28:30 INFO - 'HOME': '/home/cltbld', 04:28:30 INFO - 'LANG': 'en_US.UTF-8', 04:28:30 INFO - 'LANGUAGE': 'en_US:en', 04:28:30 INFO - 'LOGNAME': 'cltbld', 04:28:30 INFO - 'MAIL': '/var/mail/cltbld', 04:28:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:28:30 INFO - 'MOZ_NO_REMOTE': '1', 04:28:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:28:30 INFO - 'NO_EM_RESTART': '1', 04:28:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:28:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:28:30 INFO - 'PWD': '/builds/slave/test-pgo', 04:28:30 INFO - 'SHELL': '/bin/bash', 04:28:30 INFO - 'SHLVL': '1', 04:28:30 INFO - 'TERM': 'linux', 04:28:30 INFO - 'TMOUT': '86400', 04:28:30 INFO - 'USER': 'cltbld', 04:28:30 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1455625270.900196-363091807', 04:28:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:28:30 INFO - '_': '/tools/buildbot/bin/python'} 04:28:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:28:30 INFO - Downloading/unpacking psutil>=0.7.1 04:28:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:28:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:28:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:28:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:28:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:28:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:28:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 04:28:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:28:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:28:32 INFO - Installing collected packages: psutil 04:28:32 INFO - Running setup.py install for psutil 04:28:32 INFO - building 'psutil._psutil_linux' extension 04:28:32 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:28:32 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:28:32 INFO - building 'psutil._psutil_posix' extension 04:28:32 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:28:32 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:28:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:28:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:28:32 INFO - Successfully installed psutil 04:28:32 INFO - Cleaning up... 04:28:32 INFO - Return code: 0 04:28:32 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 04:28:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:28:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:28:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:28:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:28:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:28:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:28:32 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 0x7f4a82b3cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f6d600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffc350>, '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 0x1ffd250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ffd6e0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1455625270.900196-363091807', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:28:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 04:28:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:28:32 INFO - Using env: {'DISPLAY': ':0', 04:28:32 INFO - 'HOME': '/home/cltbld', 04:28:32 INFO - 'LANG': 'en_US.UTF-8', 04:28:32 INFO - 'LANGUAGE': 'en_US:en', 04:28:32 INFO - 'LOGNAME': 'cltbld', 04:28:32 INFO - 'MAIL': '/var/mail/cltbld', 04:28:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:28:32 INFO - 'MOZ_NO_REMOTE': '1', 04:28:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:28:32 INFO - 'NO_EM_RESTART': '1', 04:28:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:28:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:28:32 INFO - 'PWD': '/builds/slave/test-pgo', 04:28:32 INFO - 'SHELL': '/bin/bash', 04:28:32 INFO - 'SHLVL': '1', 04:28:32 INFO - 'TERM': 'linux', 04:28:32 INFO - 'TMOUT': '86400', 04:28:32 INFO - 'USER': 'cltbld', 04:28:32 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1455625270.900196-363091807', 04:28:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:28:32 INFO - '_': '/tools/buildbot/bin/python'} 04:28:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:28:33 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:28:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:28:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:28:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:28:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:28:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:28:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:28:34 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:28:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:28:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:28:34 INFO - Installing collected packages: mozsystemmonitor 04:28:34 INFO - Running setup.py install for mozsystemmonitor 04:28:35 INFO - Successfully installed mozsystemmonitor 04:28:35 INFO - Cleaning up... 04:28:35 INFO - Return code: 0 04:28:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 04:28:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:28:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:28:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:28:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:28:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:28:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:28:35 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 0x7f4a82b3cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f6d600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffc350>, '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 0x1ffd250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ffd6e0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1455625270.900196-363091807', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:28:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 04:28:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:28:35 INFO - Using env: {'DISPLAY': ':0', 04:28:35 INFO - 'HOME': '/home/cltbld', 04:28:35 INFO - 'LANG': 'en_US.UTF-8', 04:28:35 INFO - 'LANGUAGE': 'en_US:en', 04:28:35 INFO - 'LOGNAME': 'cltbld', 04:28:35 INFO - 'MAIL': '/var/mail/cltbld', 04:28:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:28:35 INFO - 'MOZ_NO_REMOTE': '1', 04:28:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:28:35 INFO - 'NO_EM_RESTART': '1', 04:28:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:28:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:28:35 INFO - 'PWD': '/builds/slave/test-pgo', 04:28:35 INFO - 'SHELL': '/bin/bash', 04:28:35 INFO - 'SHLVL': '1', 04:28:35 INFO - 'TERM': 'linux', 04:28:35 INFO - 'TMOUT': '86400', 04:28:35 INFO - 'USER': 'cltbld', 04:28:35 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1455625270.900196-363091807', 04:28:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:28:35 INFO - '_': '/tools/buildbot/bin/python'} 04:28:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:28:35 INFO - Downloading/unpacking blobuploader==1.2.4 04:28:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:28:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:28:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:28:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:28:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:28:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:28:37 INFO - Downloading blobuploader-1.2.4.tar.gz 04:28:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:28:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:28:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:28:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:28:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:28:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:28:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:28:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:28:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 04:28:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:28:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:28:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:28:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:28:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:28:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:28:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:28:37 INFO - Downloading docopt-0.6.1.tar.gz 04:28:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 04:28:37 INFO - Installing collected packages: blobuploader, requests, docopt 04:28:37 INFO - Running setup.py install for blobuploader 04:28:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:28:37 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 04:28:37 INFO - Running setup.py install for requests 04:28:38 INFO - Running setup.py install for docopt 04:28:38 INFO - Successfully installed blobuploader requests docopt 04:28:38 INFO - Cleaning up... 04:28:38 INFO - Return code: 0 04:28:38 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:28:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:28:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:28:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:28:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:28:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:28:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:28:38 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 0x7f4a82b3cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f6d600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffc350>, '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 0x1ffd250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ffd6e0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1455625270.900196-363091807', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:28:38 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 04:28:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:28:38 INFO - Using env: {'DISPLAY': ':0', 04:28:38 INFO - 'HOME': '/home/cltbld', 04:28:38 INFO - 'LANG': 'en_US.UTF-8', 04:28:38 INFO - 'LANGUAGE': 'en_US:en', 04:28:38 INFO - 'LOGNAME': 'cltbld', 04:28:38 INFO - 'MAIL': '/var/mail/cltbld', 04:28:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:28:38 INFO - 'MOZ_NO_REMOTE': '1', 04:28:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:28:38 INFO - 'NO_EM_RESTART': '1', 04:28:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:28:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:28:38 INFO - 'PWD': '/builds/slave/test-pgo', 04:28:38 INFO - 'SHELL': '/bin/bash', 04:28:38 INFO - 'SHLVL': '1', 04:28:38 INFO - 'TERM': 'linux', 04:28:38 INFO - 'TMOUT': '86400', 04:28:38 INFO - 'USER': 'cltbld', 04:28:38 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1455625270.900196-363091807', 04:28:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:28:38 INFO - '_': '/tools/buildbot/bin/python'} 04:28:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:28:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:28:38 INFO - Running setup.py (path:/tmp/pip-n9GRHS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:28:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:28:38 INFO - Running setup.py (path:/tmp/pip-RpmwTB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:28:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:28:38 INFO - Running setup.py (path:/tmp/pip-q0FDwg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:28:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:28:38 INFO - Running setup.py (path:/tmp/pip-UZQVcK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:28:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:28:38 INFO - Running setup.py (path:/tmp/pip-TcwULt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:28:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:28:39 INFO - Running setup.py (path:/tmp/pip-H989_m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:28:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:28:39 INFO - Running setup.py (path:/tmp/pip-p5NQed-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:28:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:28:39 INFO - Running setup.py (path:/tmp/pip-OMMMvI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:28:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:28:39 INFO - Running setup.py (path:/tmp/pip-Sqkrso-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:28:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:28:39 INFO - Running setup.py (path:/tmp/pip-8Wc3mC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:28:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:28:39 INFO - Running setup.py (path:/tmp/pip-m0OUZq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:28:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:28:39 INFO - Running setup.py (path:/tmp/pip-9mIVay-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:28:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:28:39 INFO - Running setup.py (path:/tmp/pip-9HxAo2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:28:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:28:39 INFO - Running setup.py (path:/tmp/pip-wM8_RD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:28:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:28:39 INFO - Running setup.py (path:/tmp/pip-tAVfJJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:28:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:28:39 INFO - Running setup.py (path:/tmp/pip-mujiPY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:28:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:28:39 INFO - Running setup.py (path:/tmp/pip-w3CHkY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:28:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:28:39 INFO - Running setup.py install for manifestparser 04:28:39 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 04:28:39 INFO - Running setup.py install for mozcrash 04:28:40 INFO - Running setup.py install for mozdebug 04:28:40 INFO - Running setup.py install for mozdevice 04:28:40 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 04:28:40 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 04:28:40 INFO - Running setup.py install for mozfile 04:28:40 INFO - Running setup.py install for mozhttpd 04:28:40 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 04:28:40 INFO - Running setup.py install for mozinfo 04:28:40 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 04:28:40 INFO - Running setup.py install for mozInstall 04:28:40 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 04:28:40 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 04:28:40 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 04:28:40 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 04:28:40 INFO - Running setup.py install for mozleak 04:28:40 INFO - Running setup.py install for mozlog 04:28:40 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 04:28:40 INFO - Running setup.py install for moznetwork 04:28:40 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 04:28:40 INFO - Running setup.py install for mozprocess 04:28:41 INFO - Running setup.py install for mozprofile 04:28:41 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 04:28:41 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 04:28:41 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 04:28:41 INFO - Running setup.py install for mozrunner 04:28:41 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 04:28:41 INFO - Running setup.py install for mozscreenshot 04:28:41 INFO - Running setup.py install for moztest 04:28:41 INFO - Running setup.py install for mozversion 04:28:41 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 04:28:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:28:41 INFO - Cleaning up... 04:28:41 INFO - Return code: 0 04:28:41 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:28: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')]} 04:28:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:28:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:28: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')]} 04:28:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:28:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:28:41 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 0x7f4a82b3cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f6d600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffc350>, '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 0x1ffd250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ffd6e0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1455625270.900196-363091807', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:28:41 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 04:28:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:28:41 INFO - Using env: {'DISPLAY': ':0', 04:28:41 INFO - 'HOME': '/home/cltbld', 04:28:41 INFO - 'LANG': 'en_US.UTF-8', 04:28:41 INFO - 'LANGUAGE': 'en_US:en', 04:28:41 INFO - 'LOGNAME': 'cltbld', 04:28:41 INFO - 'MAIL': '/var/mail/cltbld', 04:28:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:28:41 INFO - 'MOZ_NO_REMOTE': '1', 04:28:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:28:41 INFO - 'NO_EM_RESTART': '1', 04:28:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:28:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:28:41 INFO - 'PWD': '/builds/slave/test-pgo', 04:28:41 INFO - 'SHELL': '/bin/bash', 04:28:41 INFO - 'SHLVL': '1', 04:28:41 INFO - 'TERM': 'linux', 04:28:41 INFO - 'TMOUT': '86400', 04:28:41 INFO - 'USER': 'cltbld', 04:28:41 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1455625270.900196-363091807', 04:28:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:28:41 INFO - '_': '/tools/buildbot/bin/python'} 04:28:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:28:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:28:41 INFO - Running setup.py (path:/tmp/pip-OfCghg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:28:41 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 04:28:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:28:41 INFO - Running setup.py (path:/tmp/pip-j1RC0H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:28:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 04:28:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:28:42 INFO - Running setup.py (path:/tmp/pip-VhyNEG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:28:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 04:28:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:28:42 INFO - Running setup.py (path:/tmp/pip-GYp8eV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:28:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 04:28:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:28:42 INFO - Running setup.py (path:/tmp/pip-05yLKH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:28:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 04:28:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:28:42 INFO - Running setup.py (path:/tmp/pip-kjWTxD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:28:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 04:28:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:28:42 INFO - Running setup.py (path:/tmp/pip-W6iDEJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:28:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 04:28:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:28:42 INFO - Running setup.py (path:/tmp/pip-A4M6_M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:28:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 04:28:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:28:42 INFO - Running setup.py (path:/tmp/pip-sraBIJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:28:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 04:28:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:28:42 INFO - Running setup.py (path:/tmp/pip-d7GgiV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:28:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 04:28:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:28:42 INFO - Running setup.py (path:/tmp/pip-y2hQDl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:28:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 04:28:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:28:42 INFO - Running setup.py (path:/tmp/pip-Hv3yMJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:28:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 04:28:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:28:42 INFO - Running setup.py (path:/tmp/pip-BigQZi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:28:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 04:28:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:28:42 INFO - Running setup.py (path:/tmp/pip-6xNkfj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:28:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 04:28:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:28:42 INFO - Running setup.py (path:/tmp/pip-UgOSVd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:28:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 04:28:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:28:42 INFO - Running setup.py (path:/tmp/pip-DUv3sE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:28:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 04:28:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:28:43 INFO - Running setup.py (path:/tmp/pip-tahzxg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:28:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 04:28:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 04:28:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 04:28:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 04:28:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 04:28:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 04:28:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 04:28:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:28:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:28:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:28:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:28:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:28:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:28:44 INFO - Downloading blessings-1.6.tar.gz 04:28:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 04:28:45 INFO - Installing collected packages: blessings 04:28:45 INFO - Running setup.py install for blessings 04:28:45 INFO - Successfully installed blessings 04:28:45 INFO - Cleaning up... 04:28:45 INFO - Return code: 0 04:28:45 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 04:28:45 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:28:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:28:45 INFO - Reading from file tmpfile_stdout 04:28:45 INFO - Current package versions: 04:28:45 INFO - argparse == 1.2.1 04:28:45 INFO - blessings == 1.6 04:28:45 INFO - blobuploader == 1.2.4 04:28:45 INFO - docopt == 0.6.1 04:28:45 INFO - manifestparser == 1.1 04:28:45 INFO - mozInstall == 1.12 04:28:45 INFO - mozcrash == 0.16 04:28:45 INFO - mozdebug == 0.1 04:28:45 INFO - mozdevice == 0.47 04:28:45 INFO - mozfile == 1.2 04:28:45 INFO - mozhttpd == 0.7 04:28:45 INFO - mozinfo == 0.9 04:28:45 INFO - mozleak == 0.1 04:28:45 INFO - mozlog == 3.1 04:28:45 INFO - moznetwork == 0.27 04:28:45 INFO - mozprocess == 0.22 04:28:45 INFO - mozprofile == 0.27 04:28:45 INFO - mozrunner == 6.11 04:28:45 INFO - mozscreenshot == 0.1 04:28:45 INFO - mozsystemmonitor == 0.0 04:28:45 INFO - moztest == 0.7 04:28:45 INFO - mozversion == 1.4 04:28:45 INFO - psutil == 3.1.1 04:28:45 INFO - requests == 1.2.3 04:28:45 INFO - wsgiref == 0.1.2 04:28:45 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:28:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:28:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:28:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:28:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:28:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:28:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:28:45 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 0x7f4a82b3cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f6d600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffc350>, '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 0x1ffd250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ffd6e0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1455625270.900196-363091807', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:28:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 04:28:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:28:45 INFO - Using env: {'DISPLAY': ':0', 04:28:45 INFO - 'HOME': '/home/cltbld', 04:28:45 INFO - 'LANG': 'en_US.UTF-8', 04:28:45 INFO - 'LANGUAGE': 'en_US:en', 04:28:45 INFO - 'LOGNAME': 'cltbld', 04:28:45 INFO - 'MAIL': '/var/mail/cltbld', 04:28:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:28:45 INFO - 'MOZ_NO_REMOTE': '1', 04:28:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:28:45 INFO - 'NO_EM_RESTART': '1', 04:28:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:28:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:28:45 INFO - 'PWD': '/builds/slave/test-pgo', 04:28:45 INFO - 'SHELL': '/bin/bash', 04:28:45 INFO - 'SHLVL': '1', 04:28:45 INFO - 'TERM': 'linux', 04:28:45 INFO - 'TMOUT': '86400', 04:28:45 INFO - 'USER': 'cltbld', 04:28:45 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1455625270.900196-363091807', 04:28:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:28:45 INFO - '_': '/tools/buildbot/bin/python'} 04:28:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:28:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 04:28:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 04:28:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 04:28:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 04:28:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 04:28:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 04:28:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 04:28:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 04:28:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 04:28:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 04:28:45 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 04:28:45 INFO - Cleaning up... 04:28:45 INFO - Return code: 0 04:28:45 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 04:28:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:28:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:28:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:28:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:28:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:28:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:28:45 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 0x7f4a82b3cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f6d600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffc350>, '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 0x1ffd250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ffd6e0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1455625270.900196-363091807', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:28:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 04:28:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:28:45 INFO - Using env: {'DISPLAY': ':0', 04:28:45 INFO - 'HOME': '/home/cltbld', 04:28:45 INFO - 'LANG': 'en_US.UTF-8', 04:28:45 INFO - 'LANGUAGE': 'en_US:en', 04:28:45 INFO - 'LOGNAME': 'cltbld', 04:28:45 INFO - 'MAIL': '/var/mail/cltbld', 04:28:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:28:45 INFO - 'MOZ_NO_REMOTE': '1', 04:28:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:28:45 INFO - 'NO_EM_RESTART': '1', 04:28:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:28:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:28:45 INFO - 'PWD': '/builds/slave/test-pgo', 04:28:45 INFO - 'SHELL': '/bin/bash', 04:28:45 INFO - 'SHLVL': '1', 04:28:45 INFO - 'TERM': 'linux', 04:28:45 INFO - 'TMOUT': '86400', 04:28:45 INFO - 'USER': 'cltbld', 04:28:45 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1455625270.900196-363091807', 04:28:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:28:45 INFO - '_': '/tools/buildbot/bin/python'} 04:28:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:28:45 INFO - Downloading/unpacking jsonschema 04:28:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:28:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:28:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:28:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:28:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:28:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:28:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:28:47 INFO - Downloading/unpacking functools32 (from jsonschema) 04:28:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:28:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:28:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:28:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:28:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:28:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:28:47 INFO - Downloading functools32-3.2.3-2.tar.gz 04:28:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 04:28:47 INFO - warning: no files found matching '*.txt' 04:28:47 INFO - no previously-included directories found matching 'build' 04:28:47 INFO - no previously-included directories found matching 'dist' 04:28:47 INFO - no previously-included directories found matching '.git*' 04:28:47 INFO - Installing collected packages: jsonschema, functools32 04:28:47 INFO - Running setup.py install for functools32 04:28:47 INFO - warning: no files found matching '*.txt' 04:28:47 INFO - no previously-included directories found matching 'build' 04:28:48 INFO - no previously-included directories found matching 'dist' 04:28:48 INFO - no previously-included directories found matching '.git*' 04:28:48 INFO - Successfully installed jsonschema functools32 04:28:48 INFO - Cleaning up... 04:28:48 INFO - Return code: 0 04:28:48 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 04:28:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:28:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:28:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:28:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:28:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:28:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:28:48 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 0x7f4a82b3cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f6d600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffc350>, '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 0x1ffd250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ffd6e0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1455625270.900196-363091807', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:28:48 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 04:28:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:28:48 INFO - Using env: {'DISPLAY': ':0', 04:28:48 INFO - 'HOME': '/home/cltbld', 04:28:48 INFO - 'LANG': 'en_US.UTF-8', 04:28:48 INFO - 'LANGUAGE': 'en_US:en', 04:28:48 INFO - 'LOGNAME': 'cltbld', 04:28:48 INFO - 'MAIL': '/var/mail/cltbld', 04:28:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:28:48 INFO - 'MOZ_NO_REMOTE': '1', 04:28:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:28:48 INFO - 'NO_EM_RESTART': '1', 04:28:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:28:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:28:48 INFO - 'PWD': '/builds/slave/test-pgo', 04:28:48 INFO - 'SHELL': '/bin/bash', 04:28:48 INFO - 'SHLVL': '1', 04:28:48 INFO - 'TERM': 'linux', 04:28:48 INFO - 'TMOUT': '86400', 04:28:48 INFO - 'USER': 'cltbld', 04:28:48 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1455625270.900196-363091807', 04:28:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:28:48 INFO - '_': '/tools/buildbot/bin/python'} 04:28:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:28:48 INFO - Downloading/unpacking flake8 04:28:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:28:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:28:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:28:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:28:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:28:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:28:50 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:28:50 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:28: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 04:28: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 04:28: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 04:28: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 04:28: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 04:28: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 04:28:50 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:28:50 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:28: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 04:28: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 04:28: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 04:28: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 04:28: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 04:28: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 04:28:50 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:28: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 04:28: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 04:28: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 04:28: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 04:28: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 04:28: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 04:28:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 04:28:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:28:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:28:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:28:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:28:50 INFO - no previously-included directories found matching 'docs/_build' 04:28:50 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:28:50 INFO - Running setup.py install for pep8 04:28:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:28:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:28:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:28:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:28:50 INFO - no previously-included directories found matching 'docs/_build' 04:28:50 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 04:28:50 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:28:50 INFO - Cleaning up... 04:28:51 INFO - Return code: 0 04:28:51 INFO - Running post-action listener: _resource_record_post_action 04:28:51 INFO - Running post-action listener: _start_resource_monitoring 04:28:51 INFO - Starting resource monitoring. 04:28:51 INFO - ##### 04:28:51 INFO - ##### Running install step. 04:28:51 INFO - ##### 04:28:51 INFO - Running pre-action listener: _resource_record_pre_action 04:28:51 INFO - Running main action method: install 04:28:51 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:28:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:28:51 INFO - Reading from file tmpfile_stdout 04:28:51 INFO - Detecting whether we're running mozinstall >=1.0... 04:28:51 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 04:28:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 04:28:51 INFO - Reading from file tmpfile_stdout 04:28:51 INFO - Output received: 04:28:51 INFO - Usage: mozinstall [options] installer 04:28:51 INFO - Options: 04:28:51 INFO - -h, --help show this help message and exit 04:28:51 INFO - -d DEST, --destination=DEST 04:28:51 INFO - Directory to install application into. [default: 04:28:51 INFO - "/builds/slave/test-pgo"] 04:28:51 INFO - --app=APP Application being installed. [default: firefox] 04:28:51 INFO - mkdir: /builds/slave/test-pgo/build/application 04:28:51 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 04:28:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 04:29:05 INFO - Reading from file tmpfile_stdout 04:29:05 INFO - Output received: 04:29:05 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 04:29:05 INFO - Running post-action listener: _resource_record_post_action 04:29:05 INFO - ##### 04:29:05 INFO - ##### Running run-tests step. 04:29:05 INFO - ##### 04:29:05 INFO - Running pre-action listener: _resource_record_pre_action 04:29:05 INFO - Running main action method: run_tests 04:29:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 04:29:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 04:29:05 INFO - Python 2.7.3 04:29:05 INFO - Return code: 0 04:29:05 INFO - grabbing minidump binary from tooltool 04:29: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')]} 04:29:05 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 0x1ffc350>, '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 0x1ffd250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ffd6e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 04:29:05 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 04:29:05 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:29:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:29:05 INFO - Return code: 0 04:29:05 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 04:29:05 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 04:29:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 04:29:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 04:29:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 04:29:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 04:29:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 04:29:07 INFO - Return code: 0 04:29:07 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/1455617390/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 04:29:07 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/1455617390/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-034 --webServer localhost 04:29:07 INFO - Using env: {'DISPLAY': ':0', 04:29:07 INFO - 'HOME': '/home/cltbld', 04:29:07 INFO - 'LANG': 'en_US.UTF-8', 04:29:07 INFO - 'LANGUAGE': 'en_US:en', 04:29:07 INFO - 'LOGNAME': 'cltbld', 04:29:07 INFO - 'MAIL': '/var/mail/cltbld', 04:29:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:29:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 04:29:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:29:07 INFO - 'MOZ_NO_REMOTE': '1', 04:29:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:29:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:29:07 INFO - 'NO_EM_RESTART': '1', 04:29:07 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:29:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:29:07 INFO - 'PWD': '/builds/slave/test-pgo', 04:29:07 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 04:29:07 INFO - 'SHELL': '/bin/bash', 04:29:07 INFO - 'SHLVL': '1', 04:29:07 INFO - 'TERM': 'linux', 04:29:07 INFO - 'TMOUT': '86400', 04:29:07 INFO - 'USER': 'cltbld', 04:29:07 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1455625270.900196-363091807', 04:29:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:29:07 INFO - '_': '/tools/buildbot/bin/python'} 04:29:07 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/1455617390/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--webServer', 'localhost'] with output_timeout 3600 04:29:07 INFO - mozversion INFO | application_buildid: 20160216020950 04:29:07 INFO - mozversion INFO | application_changeset: b454ec296bf6ffd5a79d97d64c36b7bc427b2332 04:29:07 INFO - mozversion INFO | application_display_name: Nightly 04:29:07 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:29:07 INFO - mozversion INFO | application_name: Firefox 04:29:07 INFO - mozversion INFO | application_remotingname: firefox 04:29:07 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-beta 04:29:07 INFO - mozversion INFO | application_vendor: Mozilla 04:29:07 INFO - mozversion INFO | application_version: 45.0 04:29:07 INFO - mozversion INFO | platform_buildid: 20160216020950 04:29:07 INFO - mozversion INFO | platform_changeset: b454ec296bf6ffd5a79d97d64c36b7bc427b2332 04:29:07 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-beta 04:29:07 INFO - mozversion INFO | platform_version: 45.0 04:29:07 INFO - 2016-02-16 04:29:07,213 DEBUG : using testdate: 1455625747 04:29:07 INFO - 2016-02-16 04:29:07,213 DEBUG : actual date: 1455625747 04:29:07 INFO - 2016-02-16 04:29:07,225 INFO : starting webserver on 'localhost:54109' 04:29:07 INFO - 2016-02-16 04:29:07,226 INFO : Starting test suite talos-linux64-ix-034 04:29:07 INFO - 2016-02-16 04:29:07,226 INFO : Starting test dromaeo_css 04:29:07 INFO - 2016-02-16 04:29:07,227 DEBUG : operating with platform_type : linux_ 04:29:07 INFO - 2016-02-16 04:29:07,227 INFO : Initialising browser for dromaeo_css test... 04:29:07 INFO - 2016-02-16 04:29:07,240 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpXPNcdU/profile http://localhost:54109/getInfo.html 04:29:11 INFO - 2016-02-16 04:29:11,467 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:29:11 INFO - 2016-02-16 04:29:11,467 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:29:11 INFO - 2016-02-16 04:29:11,467 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:29:11 INFO - 2016-02-16 04:29:11,467 DEBUG : BROWSER_OUTPUT: __metrics 04:29:11 INFO - 2016-02-16 04:29:11,785 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:29:12 INFO - 2016-02-16 04:29:12,789 INFO : Browser initialized. 04:29:12 INFO - 2016-02-16 04:29:12,790 INFO : Running cycle 1/1 for dromaeo_css test... 04:29:12 INFO - 2016-02-16 04:29:12,790 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpXPNcdU/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:29:24 INFO - 2016-02-16 04:29:24,369 DEBUG : BROWSER_OUTPUT: RSS: Main: 134549504 04:29:24 INFO - 2016-02-16 04:29:24,369 DEBUG : BROWSER_OUTPUT: 04:30:15 INFO - 2016-02-16 04:30:15,310 DEBUG : BROWSER_OUTPUT: 1455625815306 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:32:23 INFO - 2016-02-16 04:32:23,830 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54109/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54109/tests/dromaeo/cssquery-ext.html) 04:32:24 INFO - 2016-02-16 04:32:24,835 DEBUG : BROWSER_OUTPUT: RSS: Main: 215199744 04:32:24 INFO - 2016-02-16 04:32:24,835 DEBUG : BROWSER_OUTPUT: 04:35:26 INFO - 2016-02-16 04:35:26,908 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54109/tests/dromaeo/cssquery-ext.html (next: http://localhost:54109/tests/dromaeo/cssquery-jquery.html) 04:35:27 INFO - 2016-02-16 04:35:27,470 DEBUG : BROWSER_OUTPUT: RSS: Main: 215183360 04:35:27 INFO - 2016-02-16 04:35:27,470 DEBUG : BROWSER_OUTPUT: 04:38:29 INFO - 2016-02-16 04:38:29,158 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54109/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54109/tests/dromaeo/cssquery-mootools.html) 04:38:29 INFO - 2016-02-16 04:38:29,719 DEBUG : BROWSER_OUTPUT: RSS: Main: 210694144 04:38:29 INFO - 2016-02-16 04:38:29,719 DEBUG : BROWSER_OUTPUT: 04:41:31 INFO - 2016-02-16 04:41:31,452 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54109/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54109/tests/dromaeo/cssquery-prototype.html) 04:41:32 INFO - 2016-02-16 04:41:32,021 DEBUG : BROWSER_OUTPUT: RSS: Main: 207015936 04:41:32 INFO - 2016-02-16 04:41:32,022 DEBUG : BROWSER_OUTPUT: 04:44:34 INFO - 2016-02-16 04:44:34,389 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54109/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54109/tests/dromaeo/cssquery-yui.html) 04:44:34 INFO - 2016-02-16 04:44:34,962 DEBUG : BROWSER_OUTPUT: RSS: Main: 199774208 04:44:34 INFO - 2016-02-16 04:44:34,962 DEBUG : BROWSER_OUTPUT: 04:47:37 INFO - 2016-02-16 04:47:37,017 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54109/tests/dromaeo/cssquery-yui.html (next: http://localhost:54109/tests/dromaeo/cssquery-dojo.html) 04:47:37 INFO - 2016-02-16 04:47:37,267 DEBUG : BROWSER_OUTPUT: RSS: Main: 244457472 04:47:37 INFO - 2016-02-16 04:47:37,268 DEBUG : BROWSER_OUTPUT: 04:47:37 INFO - 2016-02-16 04:47:37,268 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:47:37 INFO - 2016-02-16 04:47:37,268 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:47:37 INFO - 2016-02-16 04:47:37,268 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:47:37 INFO - 2016-02-16 04:47:37,268 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:47:37 INFO - 2016-02-16 04:47:37,272 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3283.04791610433;3376.257223410849;3402.863885444582;3403.6426175251613;3423.6234014258434;5385.219143224235;5538.889222215554;5559.499645031946;5565.749541270642;5568.331800183973;5504.724763761816;5568;5573.4147914469;5573.916391254134;5577.051901176799;4812.181929072066;5035.622328325372;5078.162103252977;5158.432572417031;5174.068667639824;4960.875978100558;5012.8496145115705;5016.49835016499;5019.899602007958;5021.623378246646;4924.80300787968;4941.160002799533;5001.724905130216;5004.299398084271;5006.073876332872;4999.775010124535;5008.524190201925;5051.621128415347;5081.568066714297;5082.08522465956;5020.297158397827;5026.246063090529;5098;5111.948880511221;5118.206677964884;5050.520200580976;5138;5150.845474635767;5302.628815982883;5314.229436731691;5914.704264786744;5915.142304365843;5917.2307600012155;5920.319163296233;5928.703564821785;5865.090910908816;5954.10688396744;5958.642481451084;5960.582759206857;5964.493018093467;5223.764930578133;5375.838724838261;5426.701531415731;5534.889302213933;5557.916631250535;5873.794417195378;5937.70311484424;5959.255093113361;5959.821205363846;5967.671778052162;5821.563382746311;5833.591648584558;5844.12338149281;5846.7076646167525;5852.297724273115;5596.888062238732;5698;5741.62679425836;5836.358000619928;5874.5887787854435;5811.476967072984;5885.352611212763;5898.94101058984;5898.94101058984;5905.261842269716;5552.750126244328;5880.882382352414;5888.116782482662;5894.941050589525;5895.02732049207;4386.605205531518;4416.646668266531;4453.087117140978;4461.843835465743;4476.194285028661;4027.335489644176;4045.1707399982934;4047.433359329696;4073.6130067643526;4081.775502347399;5378.623496355296;5547.639403438763;5606.915896261559;5608.130739735348;5611.523020543218;5724.084146536534;5807.128930660435;5825.970870145622;5841.912371314434;5857.179994800731;5660.433956604306;5689.77240910359;5702.8289151325525;5716.371199168088;5717.828465146053;4934.5312195341385;5008.949910500848;5026;5195.194744814484;5201.063808514504;6139.7988032087915;6170.012797952306;6172.444479996821;6175.166352542349;6180.505559555315;5943.227380440515;5955.791547295824;5957.672328022;5957.940420595739;5993.190919225849;5839.416058394297;5931.822045338474;5952.0476723724;6083.8174854754425;6154.907676384947;5724.141378793214;5812.709364531672;5827.9708601458415;5831.562632802642;5833.125031245348;5834.416558344132;5889.116632505158;5894.823155305347;5905.232319798399;5905.91141132892;5399.082156033405;5584.0507113789945;5587.77648894056;5699.658020518782;5722.2561067061015;5787.8553036174435;5825;5826.213461182686;5829.446202610745;5832.24180856486;5473.425290344457;5744.971275143597;5752.9712351437975;5755.7409916553015;5757.827265182052;5573;5661.858453538694;5699.715014249188;5741;5772.855678608068;5579.637323573955;5580;5584.720763961867;5588.16177573351;5588.608797384307 04:47:37 INFO - 2016-02-16 04:47:37,272 DEBUG : BROWSER_OUTPUT: |1;ext.html;629.263761399163;635.117187109917;639.0669622351367;644.4940721533595;679.3376457953499;39471.210575788464;40127.59872401275;40174.39738403919;40261.39607905884;40327.79836100816;42899.571004289945;43579.78210108953;43584.56415435845;43602;43653;7778.961105194495;7906.130325664201;7912.327452166573;8662.177093176155;10359.430231337274;10554.31396959199;10619.41593212373;10699.83950240747;10708.089812365959;10714.571417143305;10660.253782235246;10752.139828813677;10786.191035672317;10789.352638841656;10796.028357447829;10681.572737090508;10786.244962852603;10793.298435601739;10799.622013229498;10807.135429165648;10482;10624.415657138854;10663.413512256822;10666.679999600025;10675.039246467855;42150.367744483854;42359.57640423587;42394.57605423937;42411.787941060094;42450.78774606107;3625.401808701561;3630.2195028068827;3649.927001459956;3668.3030224257304;4129.540096695561;32278.354432911212;32629.51055734166;32844.6715532844;33035;33187.50218746721;4333.241682705514;4344.348347747863;4384.254676704968;4415;4416.205083085043;306434;306741.9999999978;307571;307775;307822;52619;53727.73136134294;60647.27087281083;60727;61037;64858;65798.67100664561;65945.67027164834;65953.67023164949;65955.34044659491;16466.506004819636;16471.25879335433;16592.25334859934;16602.25289861959;16692.081935493665;12587.118901676795;12620.242785432903;12646.747065058647;12654.87345126537;12655;19804.70292945607;20263.797362026486;20281.27609153209;20291.188352465735;20466.692999605017;7826.686932522635;7875.960620196863;7964.362850971908;7986.081600616004;8013;964.0070727151045;990.978914391544;1010.9797804043878;1080.9028835731738;1118.6364431559614;29314.413711725647;29621;29930.40139197204;30027.849860750994;30511.542326865114;1046.1421634259987;1089.1776708584969;1105.563302495526;1106.734383747911;1175.0893057880212;13140.474381024844;14317.498887538886;14545.200013999332;15269.312880920384;15673.294701738449;330013;333832;333923;334035;335564;53408.93182136335;53633;53769.1934620981;53777;53789.73105134449;1312.7046414556648;1372.0669944437877;1485.3464475630904;1498.4980031689288;1573.2684301799718;27927.905407094957;28019.859900700365;28753;28758.712412875604;28948.42103157967;43917.78041109774;44075.77962110169;44234;44264.77867610641;44341.11317773691;226898;228293;228743;230054;230207;32341.51487727639;33077.17307067342;33165.668343316254;33339.49990750189;33432.665673342955;44327;45354;45411.545884540734;45711.54288457073;45783.313250300605;37973;38176;38924.80537597294;39248;39323.803380982914;37701.24597507979;38657;38999.41500877546;39194.2161156781;39743;34380.14049648679;36708.632913670524;36909.63090369062;37122;37130.44304335491;31546.842265788524;32996.84511042102;33643.327133457686;33741.83129084339;34129.48805767866;24016.27951161468;24155.636581589613;25563.48873022492;25818.096366627076;26118.477630447665 04:47:37 INFO - 2016-02-16 04:47:37,276 DEBUG : BROWSER_OUTPUT: |2;jquery.html;392.93909444036177;394.58371418153854;395.1819733152374;399.28328650073115;399.7082130045067;14525.564233072999;16839.32642694291;17318.480445586636;18708.812911870893;18713.812861871378;16881.91559042203;17308.653826923455;17616.383426580072;18295.634087318245;18318.633627327446;5958.970205148979;6114.571979961404;6126.295476020248;6141.539384546155;6149.723262453201;4447.866564003069;4571.93142102867;4572.131295053946;4572.359869618256;6035.939640603604;6468.74125034998;6598.208215014181;6828.795136145899;6831.077804496379;6834.487413443987;6803.421709154728;6837.555558888681;6839.179298484189;6856.691448884812;6891.552049116792;6490.675466226717;6597.538172327939;6622.768203112868;6676.232233293184;6678.232003319632;22973.425664358358;22995.77004229953;23137.652935205984;23389.532209355886;23628.763712363;2313.306008197551;2397.532481166156;2489.626556016594;2515.72327044025;2533.3919859233833;14406.639834004129;14458.349374278183;14608.415663373453;14644.341004654816;14870.553883383516;2090.7491101067817;2092.591944570809;2108.778578249277;2125.171183238538;2162.7837216278404;66163.33836661668;72861.27138728597;76365.99999999945;76917.23082769212;77012.99999999943;15575.610609734847;16429.09639969813;16434.75347869783;16443.671126577403;16455.341786328652;25099.121530746335;25101.74898250994;25490.872545637154;25495;25551.361215969377;9615.711528654152;9632.325737198329;9638.566264518113;9710.563024663907;9736;8189.303909167668;8194.754157375288;8214.342852571779;8267.710630127916;8278.875816862752;8130.837383252302;8183.468074575134;8202.38482113832;8207.261346478846;8293.83412331762;2530.860802655872;3104.3170502489415;3119.4696901526795;3140.98429507851;3152.3922799372485;892.7500299916034;968.7674958010027;1041.1618646989245;1054.1145437832258;1089.0797276301512;16966.321347145975;17444.302227910994;17463;17731.202095905715;18073.277068917097;934.1779234273796;961.8653388525612;962.9855552166723;970.3207754571828;979.9559019844124;9362.344635875423;9494.667686630935;9606.27952903535;9679.467629280316;9784.510774461249;539096;560962;619075;629548;660181;76663.23336766561;76972.23027769763;77501;81573.18426815774;85016;1117.458032854065;1146.220570012383;1147.9024282935877;1161.529580519874;1174.653477224204;15631.921840390725;16106.194690265205;16173.919130404744;16181.352745890032;16601;37123;37502.62497374992;37694.246115078095;38094.61905380911;38671.80664096661;48492;49992.25011624756;50167.498325016284;50698.239526406396;53321.20018199652;9984.201263899016;10536.262461627612;10538.367697938149;10542.841857371992;10554;12184.390780461119;14770.926145369205;18124.637507250045;18228.635427291647;18370.448886533424;15363.15502647365;15537.378504859678;15537.84462155364;15736.055836649837;15743.842561574238;14927.85072149308;15236;15341.463048793239;15495.070295782289;15570.299336529657;15172.165530895907;15266.3893444261;15526.456574019856;15602.765958510405;15635.218239087773;9294.442333460014;9656.75858103553;9699.224062074876;9756.26827987918;10099.14157296638;10176.185905127424;11652.825207622061;15654.373825047327;15732.685346292781;16234.756478653066 04:47:37 INFO - 2016-02-16 04:47:37,277 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1528.9694206115878;1534.232883558221;1747.571844898;1842.5854182808866;1855.6752568300549;7853.80365490863;8295.419320647557;8299.709510167146;8302.70940517082;8308.418410711252;6927.341902519265;7044.788656340305;7827.295543401093;8054.355651547877;8172.836543269131;2371.6205407134817;2393.3896856301617;2420.4190994161363;2421.83047186697;2422.2733180046002;2016.7680716717546;2387.6537902004197;2414.8913298901502;2431.8419302745265;2431.9392015199583;2063.1541068162055;2304.9539009219807;2358.2099996501192;2358.2453614843257;2359.2214569192124;2314.4561028158455;2344.4490544721975;2347.084636991575;2364.101641376266;2364.385259832439;2367.4318163640773;2367.786899179065;2402.8318017738766;2404.290734233405;2405.9037638494437;8192.057913339982;8256.669733210665;8262.380321475914;8268.37987150966;8273.8345233095;4962.330085438456;5084.542391184774;5084.593232541388;5086.618503612244;5087.618428617831;3243.3999710053718;3268.7221586165206;3306.57014588102;3318.5851768528933;3367.9158021049425;1071.4535586850684;1071.8285074388139;1085.9674209773718;1111.9769811773108;1123.1576317761678;11302;11328.546858125665;11361.545538178545;11361.659150225507;11361.943190284079;4357.433533640607;4377.233984052778;4378.408914796525;4428.933565996448;4437.334399839985;9616.471094089753;9618.086281803218;9627.181689556326;9629.855552166724;9633.9036609633;4945.406551213805;4971.055499455092;4977.751112444364;4980.377452818398;4988.501149884983;4488.326750987378;4490.259107247333;4491.416115904912;4494.348319493721;4494.9325760113625;3862.729608927348;3939.365352055334;3949.1706741584017;3969.364901615728;3976.76139431635;1083.772407794372;1132.405487119269;1181.7341098252825;1234.5493894728359;1244.8132780082879;1086.8478413022183;1095.802755504017;1100.0429626225234;1341.2958196946681;1465.8973871828869;7630.96184519085;7647.349975252166;7707.113681926538;7950.1254861965135;7955.443118981616;1184.7393573413835;1197.3773637708343;1223.1621339382552;1230.6492649595002;1232.3222227774688;6204.81385558434;6223.751049958041;6274.058891166362;6285.685715714288;6289.150964619809;9567.665131720356;9813.460259685786;9935.503224838729;9943.751406214758;9954.402735835873;9520.333576649567;9782.119609235204;9796.657117001014;9801.362911410735;9814.116729494379;7553.093628764584;7566.3190312871;7570.394368450511;7615.238476152341;7685.23147685227;7537.9623101884135;7589.279018493235;7636.465447418849;7639.159692433939;7641.044869391326;8494.150584941457;8719.912800872164;8775.122487751174;8777.166169213915;8895.110488951312;8939.642414303355;9007.90992090097;9046.502442365732;9079.636814527345;9112.544372781467;7359.043324368012;7419.554826710415;7426.108866936002;7433.368163705929;7433.553986760811;7499.8500029998;7658.349040331412;7667.69329226847;7988.320992715684;8034.758957231293;6655.267920528835;7381.926180738124;7504.962475187589;7522.887156692764;7624.580648064188;6832.692528836314;7302.853942921218;7325.120985481776;7343.265673432614;7420.035395398563;7511.985881905873;7549.50928189666;7562.357199638092;7565.394768418623;7565.773026809205;6912.308769123048;6920.204176519765;6976.232614412309;6977.406920411822;6980.197277313174;6825.180978282638;6893.827654308482;6896.655167241718;6907.654617269016;6911.688973996283 04:47:37 INFO - 2016-02-16 04:47:37,278 DEBUG : BROWSER_OUTPUT: |4;prototype.html;370.44618295648;375.9172981943971;377.49792775608444;382.2145491015962;385.6201641383235;5961;5994.880102397955;6017.458428741413;6028.6081404708775;6105.236845394325;5737.225474560933;5846;5914.438128377808;6015.548833837458;6016.699165041752;4705.482396936334;4706.482286948433;4720.1739695553315;4723.433188017443;4734.597559207472;4492.73043617384;4732.550407711279;4735.526447355272;4735.834245801398;4737.028909073631;4525.208088584501;4572.245579479382;4621.953780462186;4656.650751193657;4691.765411729417;4666.4633567139535;4677.251639737643;4687.343771871941;4690.390249267573;4693.6010439112715;4176.519700234451;4184;4189.350650649154;4193.874183774492;4201.033762234703;5607.046802043662;5676.517496012844;5681.119426488859;5689.800856969986;5697;5437.157240627709;5442.319710036246;5443.237946687467;5449.918251226235;5451.945480545183;6424.839379015515;6425.742970281183;6428.421442070189;6432.388923052303;6435;4571.3828633134435;4577.06170235101;4580.129775342708;4589;4595.264757638795;6444.323346048691;6516.8696626067685;6589.604623722592;6591;6595.6372399518;4665.440147182292;4667.6732628716345;4669.789859456333;4673.088747694235;4673.112108699336;4727.267273572602;4730.030343779517;4730.5032971538185;4735.408073990751;4736.739479328601;5401.675899446046;5403.83788486346;5407.891842163135;5415.241866138744;5416.187571864252;6304.590201636879;6454.935450645434;6465.256495502983;6466.579672321378;6469.611823290617;1647.4151676155032;1676.4635316698784;1677.8489935905827;1678.806937202213;1680.9243584038747;1141.041525118904;1142.0349804415255;1144.6909334479644;1158.6871544683056;1161.4599211366756;6278.434940855345;6284.748610055638;6291.087792270096;6291.307956124822;6299.622022678654;6368.554201205871;6617.239017512951;6618.86762264752;6624.27133015368;6630.336966303331;6206.875862482725;6214.875702486015;6347.714352854133;6352.460040896575;6354.714037868307;3546.3084698484063;3595.9101022474647;3597.6762091411897;3599.856005759793;3603.6396360363756;6818;6971.3028697129885;6979.790606281819;6983.9650801745665;6985.406240469617;6836.28219036994;6852.6231057292325;6870.3473170048765;6870.3473170048765;6873.518853680194;6888.793336199922;6928.584284942919;6930.029795828588;6948.652567371611;6952.409045231111;6571.3757193066585;6626.801195964129;6654.500912431684;6663.433608143362;6664.500162487736;6582.736690532325;6590.9670451647435;6596.538242323183;6607.324033766332;6615.17310336208;6928.4803639726215;6932.965335173292;6949;6954.547954382949;6958.547694399847;4577.382053422745;4648.721076735406;4652.767361631973;4653.837115700934;4659;6660.467162626881;6674.365935236145;6682;6683.699233534599;6690.464762818866;6491;6500.577462464925;6503.902441463477;6507.967460162668;6511.544191906711;6302.369763023844;6453.419192272718;6456.7740129095255;6491.1236983008575;6497.5126865484335;6399.776007839703;6403.519736019724;6423.132877061536;6424.421802037839;6426.742930282736;6530.640814755234;6541.476681865534;6548.967255163694;6550.6069635822005;6551.148350714377;6272.341404152498;6390.169277993831;6401.3598640135615;6404.199475065617;6404.935950640434 04:47:37 INFO - 2016-02-16 04:47:37,282 DEBUG : BROWSER_OUTPUT: |5;yui.html;724.713738073461;727.6216367488909;789.2935822438916;791.7031113332498;825.6656054298012;10872.945635271823;10902.07332376747;10997.12023038157;11039.172062095346;11077.612283570077;13370.197788132718;13480.93259533701;13487.932560337185;15250;15462.768058479132;728.6720975560992;740.5445650924696;879.5250564695073;897.1566727276339;897.7800438892481;871.9869201961976;899.4378513429107;901.2474583722567;901.603294550399;901.8737376767258;928.767808047988;933.4819175357674;933.5052422216236;937.6718148647952;941.6421759731293;758.3326672528195;769.811396207927;902.4269588811087;935.7567032571546;945.394947233771;673.7911247513287;676.4385559985201;679.6499802601664;680.5032326401705;680.9421199198074;13500.122492038085;13613.11514751538;13631.591052268348;13634.863651363557;13648.522301719491;12321.568745093968;12662;13068.803967940488;13172;13350.065495415325;10625.681229563048;10739.946300268526;10742.194335424874;10958.616448424267;11644.18490705651;3825.2923209206388;3871.090293780959;3878.553966293884;3902.512185976753;3979.9403008954887;48906.75546622244;49212.26181607279;49598.25602615964;49631.25553116706;49746;10293.485325733684;10429.21780866438;10595.629152979764;10710.03609675133;10744.462776861126;18007.36974205923;18106.45680629557;18171.818281817275;18217.18022688982;18235.635287294444;7739.92260077392;7812.140664526897;7828.804279893048;7897.131315555399;8248.628811703487;4623.838165664186;4628.976855115703;4727.976360118246;4743.288506724019;4801.663883528119;3319.9170020749193;3369.679880411357;3371.3931492331617;3375.8480868360984;3378.1892345837314;593.7862369546959;595.2856572113482;596.2755252368306;596.5704692621306;616.6423474384846;633.6419922743727;641.6374748267214;715.3954908102645;724.6630316902665;747.8392145688703;8796.120387961153;9181.724548263563;9500.809983800424;9953.402795832128;9977;713.5504632081755;728.5519405565539;736.2600586410623;750.9849803003909;763.8739607964624;4509.481409637868;4562;4577.267637178035;4599.862004139881;4673.462551806586;55870.72064639732;63498;63707.362926370144;64352.356476435576;64417;53241.467585324426;54495.45504544983;54509.27453627303;54788;54958.45041549613;49351.753241233564;49875.501244987085;50659.74670126626;50905.490945090074;51400.48599513957;9465;9511.143997040299;9669.468179250209;9688.273379496424;9821;36325.273494529436;36406.81796591;36815.26369472649;36921.261574767814;37566.812165940086;42308.1538369237;42855.142897142505;44904.77547612241;45874.05455936061;46275;12179.634610961686;12252.509899603916;12331.9383403086;12502.437390317276;12739.74520509566;12730.69044702253;12826.486940522274;13144.539941102015;13294.601161965156;13829.10110842792;12101.152919295564;12125.211861228992;12330.19853709506;12436.378181090728;12517.56188533397;11611.825822612498;11645.534178632759;11882.881171188177;11927.821082683593;11936.820947685965;11292.774144517229;11474.311541307214;11777.352245626573;12026.098042646661;12411.875881241072;10043;10196;10360.430176340073;10614.73463163427;10899.56401743953;10260.230482713976;10544.57821687124;10598.470076496298;10613.893861061291;10616.8938310619 04:47:37 INFO - 2016-02-16 04:47:37,282 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:47:37 INFO - 2016-02-16 04:47:37,282 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:47:37 INFO - 2016-02-16 04:47:37,282 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,750 04:47:37 INFO - 2016-02-16 04:47:37,283 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:47:37 INFO - 2016-02-16 04:47:37,283 DEBUG : BROWSER_OUTPUT: __startTimestamp1455626857267__endTimestamp 04:47:37 INFO - 2016-02-16 04:47:37,283 DEBUG : BROWSER_OUTPUT: 04:47:37 INFO - 2016-02-16 04:47:37,283 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:47:37 INFO - 2016-02-16 04:47:37,283 DEBUG : BROWSER_OUTPUT: Number of tests: 6 04:47:37 INFO - 2016-02-16 04:47:37,284 DEBUG : BROWSER_OUTPUT: 04:47:37 INFO - 2016-02-16 04:47:37,284 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5459.08 Median:5660.43 stddev:596.71 (10.5%) stddev-sans-first:573.60 04:47:37 INFO - 2016-02-16 04:47:37,284 DEBUG : BROWSER_OUTPUT: Values: 3283.0 3376.3 3402.9 3403.6 3423.6 5385.2 5538.9 5559.5 5565.7 5568.3 5504.7 5568.0 5573.4 5573.9 5577.1 4812.2 5035.6 5078.2 5158.4 5174.1 4960.9 5012.8 5016.5 5019.9 5021.6 4924.8 4941.2 5001.7 5004.3 5006.1 4999.8 5008.5 5051.6 5081.6 5082.1 5020.3 5026.2 5098.0 5111.9 5118.2 5050.5 5138.0 5150.8 5302.6 5314.2 5914.7 5915.1 5917.2 5920.3 5928.7 5865.1 5954.1 5958.6 5960.6 5964.5 5223.8 5375.8 5426.7 5534.9 5557.9 5873.8 5937.7 5959.3 5959.8 5967.7 5821.6 5833.6 5844.1 5846.7 5852.3 5596.9 5698.0 5741.6 5836.4 5874.6 5811.5 5885.4 5898.9 5898.9 5905.3 5552.8 5880.9 5888.1 5894.9 5895.0 4386.6 4416.6 4453.1 4461.8 4476.2 4027.3 4045.2 4047.4 4073.6 4081.8 5378.6 5547.6 5606.9 5608.1 5611.5 5724.1 5807.1 5826.0 5841.9 5857.2 5660.4 5689.8 5702.8 5716.4 5717.8 4934.5 5008.9 5026.0 5195.2 5201.1 6139.8 6170.0 6172.4 6175.2 6180.5 5943.2 5955.8 5957.7 5957.9 5993.2 5839.4 5931.8 5952.0 6083.8 6154.9 5724.1 5812.7 5828.0 5831.6 5833.1 5834.4 5889.1 5894.8 5905.2 5905.9 5399.1 5584.1 5587.8 5699.7 5722.3 5787.9 5825.0 5826.2 5829.4 5832.2 5473.4 5745.0 5753.0 5755.7 5757.8 5573.0 5661.9 5699.7 5741.0 5772.9 5579.6 5580.0 5584.7 5588.2 5588.6 04:47:37 INFO - 2016-02-16 04:47:37,284 DEBUG : BROWSER_OUTPUT: 04:47:37 INFO - 2016-02-16 04:47:37,284 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:47064.61 Median:183585.75 stddev:76539.94 (41.7%) stddev-sans-first:76675.24 04:47:37 INFO - 2016-02-16 04:47:37,284 DEBUG : BROWSER_OUTPUT: Values: 629.3 635.1 639.1 644.5 679.3 39471.2 40127.6 40174.4 40261.4 40327.8 42899.6 43579.8 43584.6 43602.0 43653.0 7779.0 7906.1 7912.3 8662.2 10359.4 10554.3 10619.4 10699.8 10708.1 10714.6 10660.3 10752.1 10786.2 10789.4 10796.0 10681.6 10786.2 10793.3 10799.6 10807.1 10482.0 10624.4 10663.4 10666.7 10675.0 42150.4 42359.6 42394.6 42411.8 42450.8 3625.4 3630.2 3649.9 3668.3 4129.5 32278.4 32629.5 32844.7 33035.0 33187.5 4333.2 4344.3 4384.3 4415.0 4416.2 306434.0 306742.0 307571.0 307775.0 307822.0 52619.0 53727.7 60647.3 60727.0 61037.0 64858.0 65798.7 65945.7 65953.7 65955.3 16466.5 16471.3 16592.3 16602.3 16692.1 12587.1 12620.2 12646.7 12654.9 12655.0 19804.7 20263.8 20281.3 20291.2 20466.7 7826.7 7876.0 7964.4 7986.1 8013.0 964.0 991.0 1011.0 1080.9 1118.6 29314.4 29621.0 29930.4 30027.8 30511.5 1046.1 1089.2 1105.6 1106.7 1175.1 13140.5 14317.5 14545.2 15269.3 15673.3 330013.0 333832.0 333923.0 334035.0 335564.0 53408.9 53633.0 53769.2 53777.0 53789.7 1312.7 1372.1 1485.3 1498.5 1573.3 27927.9 28019.9 28753.0 28758.7 28948.4 43917.8 44075.8 44234.0 44264.8 44341.1 226898.0 228293.0 228743.0 230054.0 230207.0 32341.5 33077.2 33165.7 33339.5 33432.7 44327.0 45354.0 45411.5 45711.5 45783.3 37973.0 38176.0 38924.8 39248.0 39323.8 37701.2 38657.0 38999.4 39194.2 39743.0 34380.1 36708.6 36909.6 37122.0 37130.4 31546.8 32996.8 33643.3 33741.8 34129.5 24016.3 24155.6 25563.5 25818.1 26118.5 04:47:37 INFO - 2016-02-16 04:47:37,285 DEBUG : BROWSER_OUTPUT: 04:47:37 INFO - 2016-02-16 04:47:37,285 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:32392.62 Median:3130.23 stddev:98443.19 (3144.9%) stddev-sans-first:98690.02 04:47:37 INFO - 2016-02-16 04:47:37,286 DEBUG : BROWSER_OUTPUT: Values: 392.9 394.6 395.2 399.3 399.7 14525.6 16839.3 17318.5 18708.8 18713.8 16881.9 17308.7 17616.4 18295.6 18318.6 5959.0 6114.6 6126.3 6141.5 6149.7 4447.9 4571.9 4572.1 4572.4 6035.9 6468.7 6598.2 6828.8 6831.1 6834.5 6803.4 6837.6 6839.2 6856.7 6891.6 6490.7 6597.5 6622.8 6676.2 6678.2 22973.4 22995.8 23137.7 23389.5 23628.8 2313.3 2397.5 2489.6 2515.7 2533.4 14406.6 14458.3 14608.4 14644.3 14870.6 2090.7 2092.6 2108.8 2125.2 2162.8 66163.3 72861.3 76366.0 76917.2 77013.0 15575.6 16429.1 16434.8 16443.7 16455.3 25099.1 25101.7 25490.9 25495.0 25551.4 9615.7 9632.3 9638.6 9710.6 9736.0 8189.3 8194.8 8214.3 8267.7 8278.9 8130.8 8183.5 8202.4 8207.3 8293.8 2530.9 3104.3 3119.5 3141.0 3152.4 892.8 968.8 1041.2 1054.1 1089.1 16966.3 17444.3 17463.0 17731.2 18073.3 934.2 961.9 963.0 970.3 980.0 9362.3 9494.7 9606.3 9679.5 9784.5 539096.0 560962.0 619075.0 629548.0 660181.0 76663.2 76972.2 77501.0 81573.2 85016.0 1117.5 1146.2 1147.9 1161.5 1174.7 15631.9 16106.2 16173.9 16181.4 16601.0 37123.0 37502.6 37694.2 38094.6 38671.8 48492.0 49992.3 50167.5 50698.2 53321.2 9984.2 10536.3 10538.4 10542.8 10554.0 12184.4 14770.9 18124.6 18228.6 18370.4 15363.2 15537.4 15537.8 15736.1 15743.8 14927.9 15236.0 15341.5 15495.1 15570.3 15172.2 15266.4 15526.5 15602.8 15635.2 9294.4 9656.8 9699.2 9756.3 10099.1 10176.2 11652.8 15654.4 15732.7 16234.8 04:47:37 INFO - 2016-02-16 04:47:37,286 DEBUG : BROWSER_OUTPUT: 04:47:37 INFO - 2016-02-16 04:47:37,286 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5753.39 Median:6740.22 stddev:2968.90 (44.0%) stddev-sans-first:2960.25 04:47:37 INFO - 2016-02-16 04:47:37,286 DEBUG : BROWSER_OUTPUT: Values: 1529.0 1534.2 1747.6 1842.6 1855.7 7853.8 8295.4 8299.7 8302.7 8308.4 6927.3 7044.8 7827.3 8054.4 8172.8 2371.6 2393.4 2420.4 2421.8 2422.3 2016.8 2387.7 2414.9 2431.8 2431.9 2063.2 2305.0 2358.2 2358.2 2359.2 2314.5 2344.4 2347.1 2364.1 2364.4 2367.4 2367.8 2402.8 2404.3 2405.9 8192.1 8256.7 8262.4 8268.4 8273.8 4962.3 5084.5 5084.6 5086.6 5087.6 3243.4 3268.7 3306.6 3318.6 3367.9 1071.5 1071.8 1086.0 1112.0 1123.2 11302.0 11328.5 11361.5 11361.7 11361.9 4357.4 4377.2 4378.4 4428.9 4437.3 9616.5 9618.1 9627.2 9629.9 9633.9 4945.4 4971.1 4977.8 4980.4 4988.5 4488.3 4490.3 4491.4 4494.3 4494.9 3862.7 3939.4 3949.2 3969.4 3976.8 1083.8 1132.4 1181.7 1234.5 1244.8 1086.8 1095.8 1100.0 1341.3 1465.9 7631.0 7647.3 7707.1 7950.1 7955.4 1184.7 1197.4 1223.2 1230.6 1232.3 6204.8 6223.8 6274.1 6285.7 6289.2 9567.7 9813.5 9935.5 9943.8 9954.4 9520.3 9782.1 9796.7 9801.4 9814.1 7553.1 7566.3 7570.4 7615.2 7685.2 7538.0 7589.3 7636.5 7639.2 7641.0 8494.2 8719.9 8775.1 8777.2 8895.1 8939.6 9007.9 9046.5 9079.6 9112.5 7359.0 7419.6 7426.1 7433.4 7433.6 7499.9 7658.3 7667.7 7988.3 8034.8 6655.3 7381.9 7505.0 7522.9 7624.6 6832.7 7302.9 7325.1 7343.3 7420.0 7512.0 7549.5 7562.4 7565.4 7565.8 6912.3 6920.2 6976.2 6977.4 6980.2 6825.2 6893.8 6896.7 6907.7 6911.7 04:47:37 INFO - 2016-02-16 04:47:37,286 DEBUG : BROWSER_OUTPUT: 04:47:37 INFO - 2016-02-16 04:47:37,286 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5422.01 Median:6210.88 stddev:1610.69 (25.9%) stddev-sans-first:1569.95 04:47:37 INFO - 2016-02-16 04:47:37,286 DEBUG : BROWSER_OUTPUT: Values: 370.4 375.9 377.5 382.2 385.6 5961.0 5994.9 6017.5 6028.6 6105.2 5737.2 5846.0 5914.4 6015.5 6016.7 4705.5 4706.5 4720.2 4723.4 4734.6 4492.7 4732.6 4735.5 4735.8 4737.0 4525.2 4572.2 4622.0 4656.7 4691.8 4666.5 4677.3 4687.3 4690.4 4693.6 4176.5 4184.0 4189.4 4193.9 4201.0 5607.0 5676.5 5681.1 5689.8 5697.0 5437.2 5442.3 5443.2 5449.9 5451.9 6424.8 6425.7 6428.4 6432.4 6435.0 4571.4 4577.1 4580.1 4589.0 4595.3 6444.3 6516.9 6589.6 6591.0 6595.6 4665.4 4667.7 4669.8 4673.1 4673.1 4727.3 4730.0 4730.5 4735.4 4736.7 5401.7 5403.8 5407.9 5415.2 5416.2 6304.6 6454.9 6465.3 6466.6 6469.6 1647.4 1676.5 1677.8 1678.8 1680.9 1141.0 1142.0 1144.7 1158.7 1161.5 6278.4 6284.7 6291.1 6291.3 6299.6 6368.6 6617.2 6618.9 6624.3 6630.3 6206.9 6214.9 6347.7 6352.5 6354.7 3546.3 3595.9 3597.7 3599.9 3603.6 6818.0 6971.3 6979.8 6984.0 6985.4 6836.3 6852.6 6870.3 6870.3 6873.5 6888.8 6928.6 6930.0 6948.7 6952.4 6571.4 6626.8 6654.5 6663.4 6664.5 6582.7 6591.0 6596.5 6607.3 6615.2 6928.5 6933.0 6949.0 6954.5 6958.5 4577.4 4648.7 4652.8 4653.8 4659.0 6660.5 6674.4 6682.0 6683.7 6690.5 6491.0 6500.6 6503.9 6508.0 6511.5 6302.4 6453.4 6456.8 6491.1 6497.5 6399.8 6403.5 6423.1 6424.4 6426.7 6530.6 6541.5 6549.0 6550.6 6551.1 6272.3 6390.2 6401.4 6404.2 6404.9 04:47:37 INFO - 2016-02-16 04:47:37,287 DEBUG : BROWSER_OUTPUT: 04:47:37 INFO - 2016-02-16 04:47:37,287 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14505.80 Median:25225.66 stddev:16828.23 (66.7%) stddev-sans-first:16843.61 04:47:37 INFO - 2016-02-16 04:47:37,288 DEBUG : BROWSER_OUTPUT: Values: 724.7 727.6 789.3 791.7 825.7 10872.9 10902.1 10997.1 11039.2 11077.6 13370.2 13480.9 13487.9 15250.0 15462.8 728.7 740.5 879.5 897.2 897.8 872.0 899.4 901.2 901.6 901.9 928.8 933.5 933.5 937.7 941.6 758.3 769.8 902.4 935.8 945.4 673.8 676.4 679.6 680.5 680.9 13500.1 13613.1 13631.6 13634.9 13648.5 12321.6 12662.0 13068.8 13172.0 13350.1 10625.7 10739.9 10742.2 10958.6 11644.2 3825.3 3871.1 3878.6 3902.5 3979.9 48906.8 49212.3 49598.3 49631.3 49746.0 10293.5 10429.2 10595.6 10710.0 10744.5 18007.4 18106.5 18171.8 18217.2 18235.6 7739.9 7812.1 7828.8 7897.1 8248.6 4623.8 4629.0 4728.0 4743.3 4801.7 3319.9 3369.7 3371.4 3375.8 3378.2 593.8 595.3 596.3 596.6 616.6 633.6 641.6 715.4 724.7 747.8 8796.1 9181.7 9500.8 9953.4 9977.0 713.6 728.6 736.3 751.0 763.9 4509.5 4562.0 4577.3 4599.9 4673.5 55870.7 63498.0 63707.4 64352.4 64417.0 53241.5 54495.5 54509.3 54788.0 54958.5 49351.8 49875.5 50659.7 50905.5 51400.5 9465.0 9511.1 9669.5 9688.3 9821.0 36325.3 36406.8 36815.3 36921.3 37566.8 42308.2 42855.1 44904.8 45874.1 46275.0 12179.6 12252.5 12331.9 12502.4 12739.7 12730.7 12826.5 13144.5 13294.6 13829.1 12101.2 12125.2 12330.2 12436.4 12517.6 11611.8 11645.5 11882.9 11927.8 11936.8 11292.8 11474.3 11777.4 12026.1 12411.9 10043.0 10196.0 10360.4 10614.7 10899.6 10260.2 10544.6 10598.5 10613.9 10616.9 04:47:37 INFO - 2016-02-16 04:47:37,288 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:47:37 INFO - 2016-02-16 04:47:37,288 DEBUG : BROWSER_OUTPUT: 04:47:37 INFO - 2016-02-16 04:47:37,917 INFO : Browser exited with error code: 0 04:47:37 INFO - 2016-02-16 04:47:37,938 INFO : Completed test dromaeo_css (00:18:30) 04:47:37 INFO - 2016-02-16 04:47:37,938 INFO : Starting test kraken 04:47:37 INFO - 2016-02-16 04:47:37,938 DEBUG : operating with platform_type : linux_ 04:47:37 INFO - 2016-02-16 04:47:37,938 INFO : Initialising browser for kraken test... 04:47:37 INFO - 2016-02-16 04:47:37,945 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQwABYp/profile http://localhost:54109/getInfo.html 04:47:41 INFO - 2016-02-16 04:47:41,835 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:47:41 INFO - 2016-02-16 04:47:41,835 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:47:41 INFO - 2016-02-16 04:47:41,835 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:47:41 INFO - 2016-02-16 04:47:41,835 DEBUG : BROWSER_OUTPUT: __metrics 04:47:41 INFO - 2016-02-16 04:47:41,964 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:47:43 INFO - 2016-02-16 04:47:43,249 INFO : Browser initialized. 04:47:43 INFO - 2016-02-16 04:47:43,250 INFO : Running cycle 1/1 for kraken test... 04:47:43 INFO - 2016-02-16 04:47:43,250 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQwABYp/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:47:54 INFO - 2016-02-16 04:47:54,905 DEBUG : BROWSER_OUTPUT: RSS: Main: 134385664 04:47:54 INFO - 2016-02-16 04:47:54,905 DEBUG : BROWSER_OUTPUT: 04:47:57 INFO - 2016-02-16 04:47:57,340 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54109/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54109/tests/kraken/driver.html?testName=audio-beat-detection) 04:47:57 INFO - 2016-02-16 04:47:57,921 DEBUG : BROWSER_OUTPUT: RSS: Main: 164823040 04:47:57 INFO - 2016-02-16 04:47:57,921 DEBUG : BROWSER_OUTPUT: 04:48:00 INFO - 2016-02-16 04:48:00,504 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54109/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54109/tests/kraken/driver.html?testName=audio-dft) 04:48:01 INFO - 2016-02-16 04:48:01,073 DEBUG : BROWSER_OUTPUT: RSS: Main: 162820096 04:48:01 INFO - 2016-02-16 04:48:01,073 DEBUG : BROWSER_OUTPUT: 04:48:03 INFO - 2016-02-16 04:48:03,852 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54109/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54109/tests/kraken/driver.html?testName=audio-fft) 04:48:04 INFO - 2016-02-16 04:48:04,418 DEBUG : BROWSER_OUTPUT: RSS: Main: 161013760 04:48:04 INFO - 2016-02-16 04:48:04,419 DEBUG : BROWSER_OUTPUT: 04:48:06 INFO - 2016-02-16 04:48:06,419 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54109/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54109/tests/kraken/driver.html?testName=audio-oscillator) 04:48:06 INFO - 2016-02-16 04:48:06,988 DEBUG : BROWSER_OUTPUT: RSS: Main: 161574912 04:48:06 INFO - 2016-02-16 04:48:06,989 DEBUG : BROWSER_OUTPUT: 04:48:09 INFO - 2016-02-16 04:48:09,167 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54109/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54109/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:48:09 INFO - 2016-02-16 04:48:09,729 DEBUG : BROWSER_OUTPUT: RSS: Main: 160747520 04:48:09 INFO - 2016-02-16 04:48:09,730 DEBUG : BROWSER_OUTPUT: 04:48:12 INFO - 2016-02-16 04:48:12,548 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54109/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54109/tests/kraken/driver.html?testName=imaging-darkroom) 04:48:13 INFO - 2016-02-16 04:48:13,114 DEBUG : BROWSER_OUTPUT: RSS: Main: 158674944 04:48:13 INFO - 2016-02-16 04:48:13,115 DEBUG : BROWSER_OUTPUT: 04:48:16 INFO - 2016-02-16 04:48:16,447 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54109/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54109/tests/kraken/driver.html?testName=imaging-desaturate) 04:48:17 INFO - 2016-02-16 04:48:17,014 DEBUG : BROWSER_OUTPUT: RSS: Main: 161157120 04:48:17 INFO - 2016-02-16 04:48:17,014 DEBUG : BROWSER_OUTPUT: 04:48:19 INFO - 2016-02-16 04:48:19,716 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54109/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54109/tests/kraken/driver.html?testName=json-parse-financial) 04:48:20 INFO - 2016-02-16 04:48:20,290 DEBUG : BROWSER_OUTPUT: RSS: Main: 160055296 04:48:20 INFO - 2016-02-16 04:48:20,291 DEBUG : BROWSER_OUTPUT: 04:48:21 INFO - 2016-02-16 04:48:21,825 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54109/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54109/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:48:22 INFO - 2016-02-16 04:48:22,386 DEBUG : BROWSER_OUTPUT: RSS: Main: 167780352 04:48:22 INFO - 2016-02-16 04:48:22,386 DEBUG : BROWSER_OUTPUT: 04:48:24 INFO - 2016-02-16 04:48:24,136 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54109/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54109/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:48:24 INFO - 2016-02-16 04:48:24,718 DEBUG : BROWSER_OUTPUT: RSS: Main: 164347904 04:48:24 INFO - 2016-02-16 04:48:24,718 DEBUG : BROWSER_OUTPUT: 04:48:26 INFO - 2016-02-16 04:48:26,709 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54109/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54109/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:48:27 INFO - 2016-02-16 04:48:27,275 DEBUG : BROWSER_OUTPUT: RSS: Main: 169971712 04:48:27 INFO - 2016-02-16 04:48:27,275 DEBUG : BROWSER_OUTPUT: 04:48:29 INFO - 2016-02-16 04:48:29,610 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54109/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54109/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:48:30 INFO - 2016-02-16 04:48:30,191 DEBUG : BROWSER_OUTPUT: RSS: Main: 176168960 04:48:30 INFO - 2016-02-16 04:48:30,192 DEBUG : BROWSER_OUTPUT: 04:48:32 INFO - 2016-02-16 04:48:32,686 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54109/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54109/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:48:33 INFO - 2016-02-16 04:48:33,248 DEBUG : BROWSER_OUTPUT: RSS: Main: 173248512 04:48:33 INFO - 2016-02-16 04:48:33,249 DEBUG : BROWSER_OUTPUT: 04:48:34 INFO - 2016-02-16 04:48:34,906 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54109/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54109/tests/kraken/driver.html?testName=ai-astar) 04:48:35 INFO - 2016-02-16 04:48:35,156 DEBUG : BROWSER_OUTPUT: RSS: Main: 231137280 04:48:35 INFO - 2016-02-16 04:48:35,157 DEBUG : BROWSER_OUTPUT: 04:48:35 INFO - 2016-02-16 04:48:35,160 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:48:35 INFO - 2016-02-16 04:48:35,160 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:48:35 INFO - 2016-02-16 04:48:35,160 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:48:35 INFO - 2016-02-16 04:48:35,160 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:48:35 INFO - 2016-02-16 04:48:35,160 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;109;104;108;110;109;98;109;109;109 04:48:35 INFO - 2016-02-16 04:48:35,161 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;149;123;151;159;124;150;151;123;164;120 04:48:35 INFO - 2016-02-16 04:48:35,161 DEBUG : BROWSER_OUTPUT: |2;audio-dft;159;161;158;161;163;161;160;161;159;158 04:48:35 INFO - 2016-02-16 04:48:35,161 DEBUG : BROWSER_OUTPUT: |3;audio-fft;70;71;73;155;72;70;70;71;152;72 04:48:35 INFO - 2016-02-16 04:48:35,161 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;92;139;93;92;98;131;91;92;134 04:48:35 INFO - 2016-02-16 04:48:35,161 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;108;109;110;108;110;109;110;110;109;109 04:48:35 INFO - 2016-02-16 04:48:35,161 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;147;146;145;146;146;145;147;147;145 04:48:35 INFO - 2016-02-16 04:48:35,161 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;95;96;94;95;94;95;95;95 04:48:35 INFO - 2016-02-16 04:48:35,161 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;56;59;57;56;57;58;58;59;55;56 04:48:35 INFO - 2016-02-16 04:48:35,161 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;64;65;63;64;64;64;65;64;65;64 04:48:35 INFO - 2016-02-16 04:48:35,161 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;77;78;78;79;78;79;85;77;78;84 04:48:35 INFO - 2016-02-16 04:48:35,161 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;111;118;112;109;114;111;113;112;110;116 04:48:35 INFO - 2016-02-16 04:48:35,161 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;140;143;143;144;142;135;141;144;142;132 04:48:35 INFO - 2016-02-16 04:48:35,161 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;64;65;64;63;65;63;66;65;65;65 04:48:35 INFO - 2016-02-16 04:48:35,161 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:48:35 INFO - 2016-02-16 04:48:35,161 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:48:35 INFO - 2016-02-16 04:48:35,161 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,875 04:48:35 INFO - 2016-02-16 04:48:35,162 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:48:35 INFO - 2016-02-16 04:48:35,162 DEBUG : BROWSER_OUTPUT: __startTimestamp1455626915158__endTimestamp 04:48:35 INFO - 2016-02-16 04:48:35,162 DEBUG : BROWSER_OUTPUT: 04:48:35 INFO - 2016-02-16 04:48:35,163 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:48:35 INFO - 2016-02-16 04:48:35,163 DEBUG : BROWSER_OUTPUT: Number of tests: 14 04:48:35 INFO - 2016-02-16 04:48:35,163 DEBUG : BROWSER_OUTPUT: 04:48:35 INFO - 2016-02-16 04:48:35,163 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.40 Median:109.00 stddev:3.69 (3.4%) stddev-sans-first:3.87 04:48:35 INFO - 2016-02-16 04:48:35,163 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 104.0 108.0 110.0 109.0 98.0 109.0 109.0 109.0 04:48:35 INFO - 2016-02-16 04:48:35,163 DEBUG : BROWSER_OUTPUT: 04:48:35 INFO - 2016-02-16 04:48:35,164 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:141.40 Median:150.50 stddev:16.91 (11.2%) stddev-sans-first:17.71 04:48:35 INFO - 2016-02-16 04:48:35,164 DEBUG : BROWSER_OUTPUT: Values: 149.0 123.0 151.0 159.0 124.0 150.0 151.0 123.0 164.0 120.0 04:48:35 INFO - 2016-02-16 04:48:35,164 DEBUG : BROWSER_OUTPUT: 04:48:35 INFO - 2016-02-16 04:48:35,164 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.10 Median:161.00 stddev:1.60 (1.0%) stddev-sans-first:1.64 04:48:35 INFO - 2016-02-16 04:48:35,164 DEBUG : BROWSER_OUTPUT: Values: 159.0 161.0 158.0 161.0 163.0 161.0 160.0 161.0 159.0 158.0 04:48:35 INFO - 2016-02-16 04:48:35,164 DEBUG : BROWSER_OUTPUT: 04:48:35 INFO - 2016-02-16 04:48:35,164 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:87.60 Median:71.00 stddev:34.75 (48.9%) stddev-sans-first:36.27 04:48:35 INFO - 2016-02-16 04:48:35,164 DEBUG : BROWSER_OUTPUT: Values: 70.0 71.0 73.0 155.0 72.0 70.0 70.0 71.0 152.0 72.0 04:48:35 INFO - 2016-02-16 04:48:35,164 DEBUG : BROWSER_OUTPUT: 04:48:35 INFO - 2016-02-16 04:48:35,164 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.40 Median:92.00 stddev:20.38 (22.1%) stddev-sans-first:21.03 04:48:35 INFO - 2016-02-16 04:48:35,164 DEBUG : BROWSER_OUTPUT: Values: 92.0 92.0 139.0 93.0 92.0 98.0 131.0 91.0 92.0 134.0 04:48:35 INFO - 2016-02-16 04:48:35,164 DEBUG : BROWSER_OUTPUT: 04:48:35 INFO - 2016-02-16 04:48:35,165 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.50 stddev:0.79 (0.7%) stddev-sans-first:0.71 04:48:35 INFO - 2016-02-16 04:48:35,165 DEBUG : BROWSER_OUTPUT: Values: 108.0 109.0 110.0 108.0 110.0 109.0 110.0 110.0 109.0 109.0 04:48:35 INFO - 2016-02-16 04:48:35,165 DEBUG : BROWSER_OUTPUT: 04:48:35 INFO - 2016-02-16 04:48:35,165 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 04:48:35 INFO - 2016-02-16 04:48:35,166 DEBUG : BROWSER_OUTPUT: Values: 146.0 147.0 146.0 145.0 146.0 146.0 145.0 147.0 147.0 145.0 04:48:35 INFO - 2016-02-16 04:48:35,166 DEBUG : BROWSER_OUTPUT: 04:48:35 INFO - 2016-02-16 04:48:35,166 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 04:48:35 INFO - 2016-02-16 04:48:35,166 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 95.0 96.0 94.0 95.0 94.0 95.0 95.0 95.0 04:48:35 INFO - 2016-02-16 04:48:35,166 DEBUG : BROWSER_OUTPUT: 04:48:35 INFO - 2016-02-16 04:48:35,166 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:57.10 Median:57.50 stddev:1.37 (2.4%) stddev-sans-first:1.39 04:48:35 INFO - 2016-02-16 04:48:35,166 DEBUG : BROWSER_OUTPUT: Values: 56.0 59.0 57.0 56.0 57.0 58.0 58.0 59.0 55.0 56.0 04:48:35 INFO - 2016-02-16 04:48:35,167 DEBUG : BROWSER_OUTPUT: 04:48:35 INFO - 2016-02-16 04:48:35,167 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:64.20 Median:64.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 04:48:35 INFO - 2016-02-16 04:48:35,167 DEBUG : BROWSER_OUTPUT: Values: 64.0 65.0 63.0 64.0 64.0 64.0 65.0 64.0 65.0 64.0 04:48:35 INFO - 2016-02-16 04:48:35,167 DEBUG : BROWSER_OUTPUT: 04:48:35 INFO - 2016-02-16 04:48:35,167 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:79.30 Median:78.50 stddev:2.83 (3.6%) stddev-sans-first:2.88 04:48:35 INFO - 2016-02-16 04:48:35,167 DEBUG : BROWSER_OUTPUT: Values: 77.0 78.0 78.0 79.0 78.0 79.0 85.0 77.0 78.0 84.0 04:48:35 INFO - 2016-02-16 04:48:35,167 DEBUG : BROWSER_OUTPUT: 04:48:35 INFO - 2016-02-16 04:48:35,167 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:112.60 Median:112.50 stddev:2.76 (2.5%) stddev-sans-first:2.86 04:48:35 INFO - 2016-02-16 04:48:35,167 DEBUG : BROWSER_OUTPUT: Values: 111.0 118.0 112.0 109.0 114.0 111.0 113.0 112.0 110.0 116.0 04:48:35 INFO - 2016-02-16 04:48:35,167 DEBUG : BROWSER_OUTPUT: 04:48:35 INFO - 2016-02-16 04:48:35,167 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.60 Median:142.50 stddev:4.01 (2.8%) stddev-sans-first:4.24 04:48:35 INFO - 2016-02-16 04:48:35,168 DEBUG : BROWSER_OUTPUT: Values: 140.0 143.0 143.0 144.0 142.0 135.0 141.0 144.0 142.0 132.0 04:48:35 INFO - 2016-02-16 04:48:35,168 DEBUG : BROWSER_OUTPUT: 04:48:35 INFO - 2016-02-16 04:48:35,168 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.50 Median:65.00 stddev:0.97 (1.5%) stddev-sans-first:1.01 04:48:35 INFO - 2016-02-16 04:48:35,168 DEBUG : BROWSER_OUTPUT: Values: 64.0 65.0 64.0 63.0 65.0 63.0 66.0 65.0 65.0 65.0 04:48:35 INFO - 2016-02-16 04:48:35,168 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:48:35 INFO - 2016-02-16 04:48:35,168 DEBUG : BROWSER_OUTPUT: 04:48:35 INFO - 2016-02-16 04:48:35,889 INFO : Browser exited with error code: 0 04:48:35 INFO - 2016-02-16 04:48:35,942 INFO : Completed test kraken (00:00:58) 04:48:35 INFO - 2016-02-16 04:48:35,942 INFO : Starting test v8_7 04:48:35 INFO - 2016-02-16 04:48:35,942 DEBUG : operating with platform_type : linux_ 04:48:35 INFO - 2016-02-16 04:48:35,943 INFO : Initialising browser for v8_7 test... 04:48:35 INFO - 2016-02-16 04:48:35,949 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpVS05OG/profile http://localhost:54109/getInfo.html 04:48:39 INFO - 2016-02-16 04:48:39,954 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:48:39 INFO - 2016-02-16 04:48:39,954 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:48:39 INFO - 2016-02-16 04:48:39,954 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:48:39 INFO - 2016-02-16 04:48:39,954 DEBUG : BROWSER_OUTPUT: __metrics 04:48:40 INFO - 2016-02-16 04:48:40,163 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:48:41 INFO - 2016-02-16 04:48:41,445 INFO : Browser initialized. 04:48:41 INFO - 2016-02-16 04:48:41,445 INFO : Running cycle 1/1 for v8_7 test... 04:48:41 INFO - 2016-02-16 04:48:41,446 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpVS05OG/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:48:53 INFO - 2016-02-16 04:48:53,086 DEBUG : BROWSER_OUTPUT: RSS: Main: 132497408 04:48:53 INFO - 2016-02-16 04:48:53,086 DEBUG : BROWSER_OUTPUT: 04:49:14 INFO - 2016-02-16 04:49:14,468 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54109/tests/v8_7/run.html (next: http://localhost:54109/tests/v8_7/run.html) 04:49:14 INFO - 2016-02-16 04:49:14,719 DEBUG : BROWSER_OUTPUT: RSS: Main: 423870464 04:49:14 INFO - 2016-02-16 04:49:14,719 DEBUG : BROWSER_OUTPUT: 04:49:14 INFO - 2016-02-16 04:49:14,720 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:49:14 INFO - 2016-02-16 04:49:14,720 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:49:14 INFO - 2016-02-16 04:49:14,720 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:49:14 INFO - 2016-02-16 04:49:14,720 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:49:14 INFO - 2016-02-16 04:49:14,721 DEBUG : BROWSER_OUTPUT: |0;Richards;173.16017316017317 04:49:14 INFO - 2016-02-16 04:49:14,721 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;164.5548790521639 04:49:14 INFO - 2016-02-16 04:49:14,721 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.42624789680315 04:49:14 INFO - 2016-02-16 04:49:14,721 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5170.103092783505 04:49:14 INFO - 2016-02-16 04:49:14,722 DEBUG : BROWSER_OUTPUT: |4;RayTrace;955.1098376313277 04:49:14 INFO - 2016-02-16 04:49:14,722 DEBUG : BROWSER_OUTPUT: |5;Earley;541.1255411255411 04:49:14 INFO - 2016-02-16 04:49:14,722 DEBUG : BROWSER_OUTPUT: |6;Boyer;10526.315789473685 04:49:14 INFO - 2016-02-16 04:49:14,722 DEBUG : BROWSER_OUTPUT: |7;RegExp;26205.128205128207 04:49:14 INFO - 2016-02-16 04:49:14,722 DEBUG : BROWSER_OUTPUT: |8;Splay;528.8207297726071 04:49:14 INFO - 2016-02-16 04:49:14,722 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 04:49:14 INFO - 2016-02-16 04:49:14,722 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:49:14 INFO - 2016-02-16 04:49:14,722 DEBUG : BROWSER_OUTPUT: __startTimestamp1455626954716__endTimestamp 04:49:14 INFO - 2016-02-16 04:49:14,723 DEBUG : BROWSER_OUTPUT: 04:49:14 INFO - 2016-02-16 04:49:14,723 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:49:14 INFO - 2016-02-16 04:49:14,723 DEBUG : BROWSER_OUTPUT: Number of tests: 10 04:49:14 INFO - 2016-02-16 04:49:14,723 DEBUG : BROWSER_OUTPUT: 04:49:14 INFO - 2016-02-16 04:49:14,723 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:173.16 Median:173.16 stddev:0.00 (0.0%) 04:49:14 INFO - 2016-02-16 04:49:14,723 DEBUG : BROWSER_OUTPUT: Values: 173.2 04:49:14 INFO - 2016-02-16 04:49:14,723 DEBUG : BROWSER_OUTPUT: 04:49:14 INFO - 2016-02-16 04:49:14,724 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:164.55 Median:164.55 stddev:0.00 (0.0%) 04:49:14 INFO - 2016-02-16 04:49:14,724 DEBUG : BROWSER_OUTPUT: Values: 164.6 04:49:14 INFO - 2016-02-16 04:49:14,724 DEBUG : BROWSER_OUTPUT: 04:49:14 INFO - 2016-02-16 04:49:14,724 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.43 Median:280.43 stddev:0.00 (0.0%) 04:49:14 INFO - 2016-02-16 04:49:14,724 DEBUG : BROWSER_OUTPUT: Values: 280.4 04:49:14 INFO - 2016-02-16 04:49:14,724 DEBUG : BROWSER_OUTPUT: 04:49:14 INFO - 2016-02-16 04:49:14,724 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5170.10 Median:5170.10 stddev:0.00 (0.0%) 04:49:14 INFO - 2016-02-16 04:49:14,724 DEBUG : BROWSER_OUTPUT: Values: 5170.1 04:49:14 INFO - 2016-02-16 04:49:14,725 DEBUG : BROWSER_OUTPUT: 04:49:14 INFO - 2016-02-16 04:49:14,725 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:955.11 Median:955.11 stddev:0.00 (0.0%) 04:49:14 INFO - 2016-02-16 04:49:14,725 DEBUG : BROWSER_OUTPUT: Values: 955.1 04:49:14 INFO - 2016-02-16 04:49:14,725 DEBUG : BROWSER_OUTPUT: 04:49:14 INFO - 2016-02-16 04:49:14,725 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:541.13 Median:541.13 stddev:0.00 (0.0%) 04:49:14 INFO - 2016-02-16 04:49:14,725 DEBUG : BROWSER_OUTPUT: Values: 541.1 04:49:14 INFO - 2016-02-16 04:49:14,725 DEBUG : BROWSER_OUTPUT: 04:49:14 INFO - 2016-02-16 04:49:14,725 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10526.32 Median:10526.32 stddev:0.00 (0.0%) 04:49:14 INFO - 2016-02-16 04:49:14,725 DEBUG : BROWSER_OUTPUT: Values: 10526.3 04:49:14 INFO - 2016-02-16 04:49:14,725 DEBUG : BROWSER_OUTPUT: 04:49:14 INFO - 2016-02-16 04:49:14,725 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26205.13 Median:26205.13 stddev:0.00 (0.0%) 04:49:14 INFO - 2016-02-16 04:49:14,725 DEBUG : BROWSER_OUTPUT: Values: 26205.1 04:49:14 INFO - 2016-02-16 04:49:14,725 DEBUG : BROWSER_OUTPUT: 04:49:14 INFO - 2016-02-16 04:49:14,725 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:528.82 Median:528.82 stddev:0.00 (0.0%) 04:49:14 INFO - 2016-02-16 04:49:14,725 DEBUG : BROWSER_OUTPUT: Values: 528.8 04:49:14 INFO - 2016-02-16 04:49:14,725 DEBUG : BROWSER_OUTPUT: 04:49:14 INFO - 2016-02-16 04:49:14,726 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 04:49:14 INFO - 2016-02-16 04:49:14,726 DEBUG : BROWSER_OUTPUT: Values: 4840.6 04:49:14 INFO - 2016-02-16 04:49:14,726 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:49:14 INFO - 2016-02-16 04:49:14,726 DEBUG : BROWSER_OUTPUT: 04:49:15 INFO - 2016-02-16 04:49:15,433 INFO : Browser exited with error code: 0 04:49:15 INFO - 2016-02-16 04:49:15,447 INFO : Completed test v8_7 (00:00:39) 04:49:15 INFO - 2016-02-16 04:49:15,758 INFO : Completed test suite (00:20:08) 04:49:15 INFO - 2016-02-16 04:49:15,758 DEBUG : Working with test: dromaeo_css 04:49:15 INFO - 2016-02-16 04:49:15,758 DEBUG : Generating results file: dromaeo_css 04:49:15 INFO - 2016-02-16 04:49:15,760 DEBUG : Working with test: kraken 04:49:15 INFO - 2016-02-16 04:49:15,760 DEBUG : Generating results file: kraken 04:49:15 INFO - 2016-02-16 04:49:15,760 INFO : javascript benchmark 04:49:15 INFO - 2016-02-16 04:49:15,761 DEBUG : Working with test: v8_7 04:49:15 INFO - 2016-02-16 04:49:15,761 DEBUG : Generating results file: v8_7 04:49:15 INFO - 2016-02-16 04:49:15,761 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:49:15 INFO - 2016-02-16 04:49:15,820 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,53,35]] 04:49:15 INFO - 2016-02-16 04:49:15,820 DEBUG : process_Request line: dromaeo_css 7434.36 graph.html#tests=[[72,53,35]] 04:49:15 INFO - 2016-02-16 04:49:15,820 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:49:15 INFO - 2016-02-16 04:49:15,856 DEBUG : process_Request line: kraken 1470.40 graph.html#tests=[[232,53,35]] 04:49:15 INFO - 2016-02-16 04:49:15,856 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:49:15 INFO - 2016-02-16 04:49:15,886 DEBUG : process_Request line: v8_7 22995.55 graph.html#tests=[[230,53,35]] 04:49:15 INFO - 2016-02-16 04:49:15,887 INFO : javascript benchmark 04:49:15 INFO - 2016-02-16 04:49:15,889 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3283.04791610433, 3376.257223410849, 3402.863885444582, 3403.6426175251613, 3423.6234014258434, 5385.219143224235, 5538.889222215554, 5559.499645031946, 5565.749541270642, 5568.331800183973, 5504.724763761816, 5568.0, 5573.4147914469, 5573.916391254134, 5577.051901176799, 4812.181929072066, 5035.622328325372, 5078.162103252977, 5158.432572417031, 5174.068667639824, 4960.875978100558, 5012.8496145115705, 5016.49835016499, 5019.899602007958, 5021.623378246646, 4924.80300787968, 4941.160002799533, 5001.724905130216, 5004.299398084271, 5006.073876332872, 4999.775010124535, 5008.524190201925, 5051.621128415347, 5081.568066714297, 5082.08522465956, 5020.297158397827, 5026.246063090529, 5098.0, 5111.948880511221, 5118.206677964884, 5050.520200580976, 5138.0, 5150.845474635767, 5302.628815982883, 5314.229436731691, 5914.704264786744, 5915.142304365843, 5917.2307600012155, 5920.319163296233, 5928.703564821785, 5865.090910908816, 5954.10688396744, 5958.642481451084, 5960.582759206857, 5964.493018093467, 5223.764930578133, 5375.838724838261, 5426.701531415731, 5534.889302213933, 5557.916631250535, 5873.794417195378, 5937.70311484424, 5959.255093113361, 5959.821205363846, 5967.671778052162, 5821.563382746311, 5833.591648584558, 5844.12338149281, 5846.7076646167525, 5852.297724273115, 5596.888062238732, 5698.0, 5741.62679425836, 5836.358000619928, 5874.5887787854435, 5811.476967072984, 5885.352611212763, 5898.94101058984, 5898.94101058984, 5905.261842269716, 5552.750126244328, 5880.882382352414, 5888.116782482662, 5894.941050589525, 5895.02732049207, 4386.605205531518, 4416.646668266531, 4453.087117140978, 4461.843835465743, 4476.194285028661, 4027.335489644176, 4045.1707399982934, 4047.433359329696, 4073.6130067643526, 4081.775502347399, 5378.623496355296, 5547.639403438763, 5606.915896261559, 5608.130739735348, 5611.523020543218, 5724.084146536534, 5807.128930660435, 5825.970870145622, 5841.912371314434, 5857.179994800731, 5660.433956604306, 5689.77240910359, 5702.8289151325525, 5716.371199168088, 5717.828465146053, 4934.5312195341385, 5008.949910500848, 5026.0, 5195.194744814484, 5201.063808514504, 6139.7988032087915, 6170.012797952306, 6172.444479996821, 6175.166352542349, 6180.505559555315, 5943.227380440515, 5955.791547295824, 5957.672328022, 5957.940420595739, 5993.190919225849, 5839.416058394297, 5931.822045338474, 5952.0476723724, 6083.8174854754425, 6154.907676384947, 5724.141378793214, 5812.709364531672, 5827.9708601458415, 5831.562632802642, 5833.125031245348, 5834.416558344132, 5889.116632505158, 5894.823155305347, 5905.232319798399, 5905.91141132892, 5399.082156033405, 5584.0507113789945, 5587.77648894056, 5699.658020518782, 5722.2561067061015, 5787.8553036174435, 5825.0, 5826.213461182686, 5829.446202610745, 5832.24180856486, 5473.425290344457, 5744.971275143597, 5752.9712351437975, 5755.7409916553015, 5757.827265182052, 5573.0, 5661.858453538694, 5699.715014249188, 5741.0, 5772.855678608068, 5579.637323573955, 5580.0, 5584.720763961867, 5588.16177573351, 5588.608797384307], "unit": "ms", "name": "dojo.html", "value": 5421.601780267263}, {"lowerIsBetter": false, "replicates": [629.263761399163, 635.117187109917, 639.0669622351367, 644.4940721533595, 679.3376457953499, 39471.210575788464, 40127.59872401275, 40174.39738403919, 40261.39607905884, 40327.79836100816, 42899.571004289945, 43579.78210108953, 43584.56415435845, 43602.0, 43653.0, 7778.961105194495, 7906.130325664201, 7912.327452166573, 8662.177093176155, 10359.430231337274, 10554.31396959199, 10619.41593212373, 10699.83950240747, 10708.089812365959, 10714.571417143305, 10660.253782235246, 10752.139828813677, 10786.191035672317, 10789.352638841656, 10796.028357447829, 10681.572737090508, 10786.244962852603, 10793.298435601739, 10799.622013229498, 10807.135429165648, 10482.0, 10624.415657138854, 10663.413512256822, 10666.679999600025, 10675.039246467855, 42150.367744483854, 42359.57640423587, 42394.57605423937, 42411.787941060094, 42450.78774606107, 3625.401808701561, 3630.2195028068827, 3649.927001459956, 3668.3030224257304, 4129.540096695561, 32278.354432911212, 32629.51055734166, 32844.6715532844, 33035.0, 33187.50218746721, 4333.241682705514, 4344.348347747863, 4384.254676704968, 4415.0, 4416.205083085043, 306434.0, 306741.9999999978, 307571.0, 307775.0, 307822.0, 52619.0, 53727.73136134294, 60647.27087281083, 60727.0, 61037.0, 64858.0, 65798.67100664561, 65945.67027164834, 65953.67023164949, 65955.34044659491, 16466.506004819636, 16471.25879335433, 16592.25334859934, 16602.25289861959, 16692.081935493665, 12587.118901676795, 12620.242785432903, 12646.747065058647, 12654.87345126537, 12655.0, 19804.70292945607, 20263.797362026486, 20281.27609153209, 20291.188352465735, 20466.692999605017, 7826.686932522635, 7875.960620196863, 7964.362850971908, 7986.081600616004, 8013.0, 964.0070727151045, 990.978914391544, 1010.9797804043878, 1080.9028835731738, 1118.6364431559614, 29314.413711725647, 29621.0, 29930.40139197204, 30027.849860750994, 30511.542326865114, 1046.1421634259987, 1089.1776708584969, 1105.563302495526, 1106.734383747911, 1175.0893057880212, 13140.474381024844, 14317.498887538886, 14545.200013999332, 15269.312880920384, 15673.294701738449, 330013.0, 333832.0, 333923.0, 334035.0, 335564.0, 53408.93182136335, 53633.0, 53769.1934620981, 53777.0, 53789.73105134449, 1312.7046414556648, 1372.0669944437877, 1485.3464475630904, 1498.4980031689288, 1573.2684301799718, 27927.905407094957, 28019.859900700365, 28753.0, 28758.712412875604, 28948.42103157967, 43917.78041109774, 44075.77962110169, 44234.0, 44264.77867610641, 44341.11317773691, 226898.0, 228293.0, 228743.0, 230054.0, 230207.0, 32341.51487727639, 33077.17307067342, 33165.668343316254, 33339.49990750189, 33432.665673342955, 44327.0, 45354.0, 45411.545884540734, 45711.54288457073, 45783.313250300605, 37973.0, 38176.0, 38924.80537597294, 39248.0, 39323.803380982914, 37701.24597507979, 38657.0, 38999.41500877546, 39194.2161156781, 39743.0, 34380.14049648679, 36708.632913670524, 36909.63090369062, 37122.0, 37130.44304335491, 31546.842265788524, 32996.84511042102, 33643.327133457686, 33741.83129084339, 34129.48805767866, 24016.27951161468, 24155.636581589613, 25563.48873022492, 25818.096366627076, 26118.477630447665], "unit": "ms", "name": "ext.html", "value": 19519.658900720813}, {"lowerIsBetter": false, "replicates": [392.93909444036177, 394.58371418153854, 395.1819733152374, 399.28328650073115, 399.7082130045067, 14525.564233072999, 16839.32642694291, 17318.480445586636, 18708.812911870893, 18713.812861871378, 16881.91559042203, 17308.653826923455, 17616.383426580072, 18295.634087318245, 18318.633627327446, 5958.970205148979, 6114.571979961404, 6126.295476020248, 6141.539384546155, 6149.723262453201, 4447.866564003069, 4571.93142102867, 4572.131295053946, 4572.359869618256, 6035.939640603604, 6468.74125034998, 6598.208215014181, 6828.795136145899, 6831.077804496379, 6834.487413443987, 6803.421709154728, 6837.555558888681, 6839.179298484189, 6856.691448884812, 6891.552049116792, 6490.675466226717, 6597.538172327939, 6622.768203112868, 6676.232233293184, 6678.232003319632, 22973.425664358358, 22995.77004229953, 23137.652935205984, 23389.532209355886, 23628.763712363, 2313.306008197551, 2397.532481166156, 2489.626556016594, 2515.72327044025, 2533.3919859233833, 14406.639834004129, 14458.349374278183, 14608.415663373453, 14644.341004654816, 14870.553883383516, 2090.7491101067817, 2092.591944570809, 2108.778578249277, 2125.171183238538, 2162.7837216278404, 66163.33836661668, 72861.27138728597, 76365.99999999945, 76917.23082769212, 77012.99999999943, 15575.610609734847, 16429.09639969813, 16434.75347869783, 16443.671126577403, 16455.341786328652, 25099.121530746335, 25101.74898250994, 25490.872545637154, 25495.0, 25551.361215969377, 9615.711528654152, 9632.325737198329, 9638.566264518113, 9710.563024663907, 9736.0, 8189.303909167668, 8194.754157375288, 8214.342852571779, 8267.710630127916, 8278.875816862752, 8130.837383252302, 8183.468074575134, 8202.38482113832, 8207.261346478846, 8293.83412331762, 2530.860802655872, 3104.3170502489415, 3119.4696901526795, 3140.98429507851, 3152.3922799372485, 892.7500299916034, 968.7674958010027, 1041.1618646989245, 1054.1145437832258, 1089.0797276301512, 16966.321347145975, 17444.302227910994, 17463.0, 17731.202095905715, 18073.277068917097, 934.1779234273796, 961.8653388525612, 962.9855552166723, 970.3207754571828, 979.9559019844124, 9362.344635875423, 9494.667686630935, 9606.27952903535, 9679.467629280316, 9784.510774461249, 539096.0, 560962.0, 619075.0, 629548.0, 660181.0, 76663.23336766561, 76972.23027769763, 77501.0, 81573.18426815774, 85016.0, 1117.458032854065, 1146.220570012383, 1147.9024282935877, 1161.529580519874, 1174.653477224204, 15631.921840390725, 16106.194690265205, 16173.919130404744, 16181.352745890032, 16601.0, 37123.0, 37502.62497374992, 37694.246115078095, 38094.61905380911, 38671.80664096661, 48492.0, 49992.25011624756, 50167.498325016284, 50698.239526406396, 53321.20018199652, 9984.201263899016, 10536.262461627612, 10538.367697938149, 10542.841857371992, 10554.0, 12184.390780461119, 14770.926145369205, 18124.637507250045, 18228.635427291647, 18370.448886533424, 15363.15502647365, 15537.378504859678, 15537.84462155364, 15736.055836649837, 15743.842561574238, 14927.85072149308, 15236.0, 15341.463048793239, 15495.070295782289, 15570.299336529657, 15172.165530895907, 15266.3893444261, 15526.456574019856, 15602.765958510405, 15635.218239087773, 9294.442333460014, 9656.75858103553, 9699.224062074876, 9756.26827987918, 10099.14157296638, 10176.185905127424, 11652.825207622061, 15654.373825047327, 15732.685346292781, 16234.756478653066], "unit": "ms", "name": "jquery.html", "value": 10277.75006297097}, {"lowerIsBetter": false, "replicates": [1528.9694206115878, 1534.232883558221, 1747.571844898, 1842.5854182808866, 1855.6752568300549, 7853.80365490863, 8295.419320647557, 8299.709510167146, 8302.70940517082, 8308.418410711252, 6927.341902519265, 7044.788656340305, 7827.295543401093, 8054.355651547877, 8172.836543269131, 2371.6205407134817, 2393.3896856301617, 2420.4190994161363, 2421.83047186697, 2422.2733180046002, 2016.7680716717546, 2387.6537902004197, 2414.8913298901502, 2431.8419302745265, 2431.9392015199583, 2063.1541068162055, 2304.9539009219807, 2358.2099996501192, 2358.2453614843257, 2359.2214569192124, 2314.4561028158455, 2344.4490544721975, 2347.084636991575, 2364.101641376266, 2364.385259832439, 2367.4318163640773, 2367.786899179065, 2402.8318017738766, 2404.290734233405, 2405.9037638494437, 8192.057913339982, 8256.669733210665, 8262.380321475914, 8268.37987150966, 8273.8345233095, 4962.330085438456, 5084.542391184774, 5084.593232541388, 5086.618503612244, 5087.618428617831, 3243.3999710053718, 3268.7221586165206, 3306.57014588102, 3318.5851768528933, 3367.9158021049425, 1071.4535586850684, 1071.8285074388139, 1085.9674209773718, 1111.9769811773108, 1123.1576317761678, 11302.0, 11328.546858125665, 11361.545538178545, 11361.659150225507, 11361.943190284079, 4357.433533640607, 4377.233984052778, 4378.408914796525, 4428.933565996448, 4437.334399839985, 9616.471094089753, 9618.086281803218, 9627.181689556326, 9629.855552166724, 9633.9036609633, 4945.406551213805, 4971.055499455092, 4977.751112444364, 4980.377452818398, 4988.501149884983, 4488.326750987378, 4490.259107247333, 4491.416115904912, 4494.348319493721, 4494.9325760113625, 3862.729608927348, 3939.365352055334, 3949.1706741584017, 3969.364901615728, 3976.76139431635, 1083.772407794372, 1132.405487119269, 1181.7341098252825, 1234.5493894728359, 1244.8132780082879, 1086.8478413022183, 1095.802755504017, 1100.0429626225234, 1341.2958196946681, 1465.8973871828869, 7630.96184519085, 7647.349975252166, 7707.113681926538, 7950.1254861965135, 7955.443118981616, 1184.7393573413835, 1197.3773637708343, 1223.1621339382552, 1230.6492649595002, 1232.3222227774688, 6204.81385558434, 6223.751049958041, 6274.058891166362, 6285.685715714288, 6289.150964619809, 9567.665131720356, 9813.460259685786, 9935.503224838729, 9943.751406214758, 9954.402735835873, 9520.333576649567, 9782.119609235204, 9796.657117001014, 9801.362911410735, 9814.116729494379, 7553.093628764584, 7566.3190312871, 7570.394368450511, 7615.238476152341, 7685.23147685227, 7537.9623101884135, 7589.279018493235, 7636.465447418849, 7639.159692433939, 7641.044869391326, 8494.150584941457, 8719.912800872164, 8775.122487751174, 8777.166169213915, 8895.110488951312, 8939.642414303355, 9007.90992090097, 9046.502442365732, 9079.636814527345, 9112.544372781467, 7359.043324368012, 7419.554826710415, 7426.108866936002, 7433.368163705929, 7433.553986760811, 7499.8500029998, 7658.349040331412, 7667.69329226847, 7988.320992715684, 8034.758957231293, 6655.267920528835, 7381.926180738124, 7504.962475187589, 7522.887156692764, 7624.580648064188, 6832.692528836314, 7302.853942921218, 7325.120985481776, 7343.265673432614, 7420.035395398563, 7511.985881905873, 7549.50928189666, 7562.357199638092, 7565.394768418623, 7565.773026809205, 6912.308769123048, 6920.204176519765, 6976.232614412309, 6977.406920411822, 6980.197277313174, 6825.180978282638, 6893.827654308482, 6896.655167241718, 6907.654617269016, 6911.688973996283], "unit": "ms", "name": "mootools.html", "value": 4732.056734965699}, {"lowerIsBetter": false, "replicates": [370.44618295648, 375.9172981943971, 377.49792775608444, 382.2145491015962, 385.6201641383235, 5961.0, 5994.880102397955, 6017.458428741413, 6028.6081404708775, 6105.236845394325, 5737.225474560933, 5846.0, 5914.438128377808, 6015.548833837458, 6016.699165041752, 4705.482396936334, 4706.482286948433, 4720.1739695553315, 4723.433188017443, 4734.597559207472, 4492.73043617384, 4732.550407711279, 4735.526447355272, 4735.834245801398, 4737.028909073631, 4525.208088584501, 4572.245579479382, 4621.953780462186, 4656.650751193657, 4691.765411729417, 4666.4633567139535, 4677.251639737643, 4687.343771871941, 4690.390249267573, 4693.6010439112715, 4176.519700234451, 4184.0, 4189.350650649154, 4193.874183774492, 4201.033762234703, 5607.046802043662, 5676.517496012844, 5681.119426488859, 5689.800856969986, 5697.0, 5437.157240627709, 5442.319710036246, 5443.237946687467, 5449.918251226235, 5451.945480545183, 6424.839379015515, 6425.742970281183, 6428.421442070189, 6432.388923052303, 6435.0, 4571.3828633134435, 4577.06170235101, 4580.129775342708, 4589.0, 4595.264757638795, 6444.323346048691, 6516.8696626067685, 6589.604623722592, 6591.0, 6595.6372399518, 4665.440147182292, 4667.6732628716345, 4669.789859456333, 4673.088747694235, 4673.112108699336, 4727.267273572602, 4730.030343779517, 4730.5032971538185, 4735.408073990751, 4736.739479328601, 5401.675899446046, 5403.83788486346, 5407.891842163135, 5415.241866138744, 5416.187571864252, 6304.590201636879, 6454.935450645434, 6465.256495502983, 6466.579672321378, 6469.611823290617, 1647.4151676155032, 1676.4635316698784, 1677.8489935905827, 1678.806937202213, 1680.9243584038747, 1141.041525118904, 1142.0349804415255, 1144.6909334479644, 1158.6871544683056, 1161.4599211366756, 6278.434940855345, 6284.748610055638, 6291.087792270096, 6291.307956124822, 6299.622022678654, 6368.554201205871, 6617.239017512951, 6618.86762264752, 6624.27133015368, 6630.336966303331, 6206.875862482725, 6214.875702486015, 6347.714352854133, 6352.460040896575, 6354.714037868307, 3546.3084698484063, 3595.9101022474647, 3597.6762091411897, 3599.856005759793, 3603.6396360363756, 6818.0, 6971.3028697129885, 6979.790606281819, 6983.9650801745665, 6985.406240469617, 6836.28219036994, 6852.6231057292325, 6870.3473170048765, 6870.3473170048765, 6873.518853680194, 6888.793336199922, 6928.584284942919, 6930.029795828588, 6948.652567371611, 6952.409045231111, 6571.3757193066585, 6626.801195964129, 6654.500912431684, 6663.433608143362, 6664.500162487736, 6582.736690532325, 6590.9670451647435, 6596.538242323183, 6607.324033766332, 6615.17310336208, 6928.4803639726215, 6932.965335173292, 6949.0, 6954.547954382949, 6958.547694399847, 4577.382053422745, 4648.721076735406, 4652.767361631973, 4653.837115700934, 4659.0, 6660.467162626881, 6674.365935236145, 6682.0, 6683.699233534599, 6690.464762818866, 6491.0, 6500.577462464925, 6503.902441463477, 6507.967460162668, 6511.544191906711, 6302.369763023844, 6453.419192272718, 6456.7740129095255, 6491.1236983008575, 6497.5126865484335, 6399.776007839703, 6403.519736019724, 6423.132877061536, 6424.421802037839, 6426.742930282736, 6530.640814755234, 6541.476681865534, 6548.967255163694, 6550.6069635822005, 6551.148350714377, 6272.341404152498, 6390.169277993831, 6401.3598640135615, 6404.199475065617, 6404.935950640434], "unit": "ms", "name": "prototype.html", "value": 4913.065296340648}, {"lowerIsBetter": false, "replicates": [724.713738073461, 727.6216367488909, 789.2935822438916, 791.7031113332498, 825.6656054298012, 10872.945635271823, 10902.07332376747, 10997.12023038157, 11039.172062095346, 11077.612283570077, 13370.197788132718, 13480.93259533701, 13487.932560337185, 15250.0, 15462.768058479132, 728.6720975560992, 740.5445650924696, 879.5250564695073, 897.1566727276339, 897.7800438892481, 871.9869201961976, 899.4378513429107, 901.2474583722567, 901.603294550399, 901.8737376767258, 928.767808047988, 933.4819175357674, 933.5052422216236, 937.6718148647952, 941.6421759731293, 758.3326672528195, 769.811396207927, 902.4269588811087, 935.7567032571546, 945.394947233771, 673.7911247513287, 676.4385559985201, 679.6499802601664, 680.5032326401705, 680.9421199198074, 13500.122492038085, 13613.11514751538, 13631.591052268348, 13634.863651363557, 13648.522301719491, 12321.568745093968, 12662.0, 13068.803967940488, 13172.0, 13350.065495415325, 10625.681229563048, 10739.946300268526, 10742.194335424874, 10958.616448424267, 11644.18490705651, 3825.2923209206388, 3871.090293780959, 3878.553966293884, 3902.512185976753, 3979.9403008954887, 48906.75546622244, 49212.26181607279, 49598.25602615964, 49631.25553116706, 49746.0, 10293.485325733684, 10429.21780866438, 10595.629152979764, 10710.03609675133, 10744.462776861126, 18007.36974205923, 18106.45680629557, 18171.818281817275, 18217.18022688982, 18235.635287294444, 7739.92260077392, 7812.140664526897, 7828.804279893048, 7897.131315555399, 8248.628811703487, 4623.838165664186, 4628.976855115703, 4727.976360118246, 4743.288506724019, 4801.663883528119, 3319.9170020749193, 3369.679880411357, 3371.3931492331617, 3375.8480868360984, 3378.1892345837314, 593.7862369546959, 595.2856572113482, 596.2755252368306, 596.5704692621306, 616.6423474384846, 633.6419922743727, 641.6374748267214, 715.3954908102645, 724.6630316902665, 747.8392145688703, 8796.120387961153, 9181.724548263563, 9500.809983800424, 9953.402795832128, 9977.0, 713.5504632081755, 728.5519405565539, 736.2600586410623, 750.9849803003909, 763.8739607964624, 4509.481409637868, 4562.0, 4577.267637178035, 4599.862004139881, 4673.462551806586, 55870.72064639732, 63498.0, 63707.362926370144, 64352.356476435576, 64417.0, 53241.467585324426, 54495.45504544983, 54509.27453627303, 54788.0, 54958.45041549613, 49351.753241233564, 49875.501244987085, 50659.74670126626, 50905.490945090074, 51400.48599513957, 9465.0, 9511.143997040299, 9669.468179250209, 9688.273379496424, 9821.0, 36325.273494529436, 36406.81796591, 36815.26369472649, 36921.261574767814, 37566.812165940086, 42308.1538369237, 42855.142897142505, 44904.77547612241, 45874.05455936061, 46275.0, 12179.634610961686, 12252.509899603916, 12331.9383403086, 12502.437390317276, 12739.74520509566, 12730.69044702253, 12826.486940522274, 13144.539941102015, 13294.601161965156, 13829.10110842792, 12101.152919295564, 12125.211861228992, 12330.19853709506, 12436.378181090728, 12517.56188533397, 11611.825822612498, 11645.534178632759, 11882.881171188177, 11927.821082683593, 11936.820947685965, 11292.774144517229, 11474.311541307214, 11777.352245626573, 12026.098042646661, 12411.875881241072, 10043.0, 10196.0, 10360.430176340073, 10614.73463163427, 10899.56401743953, 10260.230482713976, 10544.57821687124, 10598.470076496298, 10613.893861061291, 10616.8938310619], "unit": "ms", "name": "yui.html", "value": 6676.082831297077}], "name": "dromaeo_css", "value": 7434.359668292272}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 109.0, 104.0, 108.0, 110.0, 109.0, 98.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "ai-astar", "value": 107.4}, {"lowerIsBetter": true, "replicates": [149.0, 123.0, 151.0, 159.0, 124.0, 150.0, 151.0, 123.0, 164.0, 120.0], "unit": "ms", "name": "audio-beat-detection", "value": 141.4}, {"lowerIsBetter": true, "replicates": [159.0, 161.0, 158.0, 161.0, 163.0, 161.0, 160.0, 161.0, 159.0, 158.0], "unit": "ms", "name": "audio-dft", "value": 160.1}, {"lowerIsBetter": true, "replicates": [70.0, 71.0, 73.0, 155.0, 72.0, 70.0, 70.0, 71.0, 152.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 87.6}, {"lowerIsBetter": true, "replicates": [92.0, 92.0, 139.0, 93.0, 92.0, 98.0, 131.0, 91.0, 92.0, 134.0], "unit": "ms", "name": "audio-oscillator", "value": 105.4}, {"lowerIsBetter": true, "replicates": [108.0, 109.0, 110.0, 108.0, 110.0, 109.0, 110.0, 110.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 146.0, 145.0, 146.0, 146.0, 145.0, 147.0, 147.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.0}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 96.0, 94.0, 95.0, 94.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.0}, {"lowerIsBetter": true, "replicates": [56.0, 59.0, 57.0, 56.0, 57.0, 58.0, 58.0, 59.0, 55.0, 56.0], "unit": "ms", "name": "json-parse-financial", "value": 57.1}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 63.0, 64.0, 64.0, 64.0, 65.0, 64.0, 65.0, 64.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 64.2}, {"lowerIsBetter": true, "replicates": [77.0, 78.0, 78.0, 79.0, 78.0, 79.0, 85.0, 77.0, 78.0, 84.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 79.3}, {"lowerIsBetter": true, "replicates": [111.0, 118.0, 112.0, 109.0, 114.0, 111.0, 113.0, 112.0, 110.0, 116.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 112.6}, {"lowerIsBetter": true, "replicates": [140.0, 143.0, 143.0, 144.0, 142.0, 135.0, 141.0, 144.0, 142.0, 132.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 140.6}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 64.0, 63.0, 65.0, 63.0, 66.0, 65.0, 65.0, 65.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 64.5}], "name": "kraken", "value": 1470.3999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [173.16017316017317], "unit": "score", "name": "Richards", "value": 203.86904999999993}, {"lowerIsBetter": false, "replicates": [164.5548790521639], "unit": "score", "name": "DeltaBlue", "value": 401.79908599999993}, {"lowerIsBetter": false, "replicates": [280.42624789680315], "unit": "score", "name": "Encrypt", "value": 949.2014460000001}, {"lowerIsBetter": false, "replicates": [5170.103092783505], "unit": "score", "name": "Decrypt", "value": 51.48466001994015}, {"lowerIsBetter": false, "replicates": [955.1098376313277], "unit": "score", "name": "RayTrace", "value": 774.7684829999998}, {"lowerIsBetter": false, "replicates": [541.1255411255411], "unit": "score", "name": "Earley", "value": 1231.623624}, {"lowerIsBetter": false, "replicates": [10526.315789473685], "unit": "score", "name": "Boyer", "value": 63.313984999999995}, {"lowerIsBetter": false, "replicates": [26205.128205128207], "unit": "score", "name": "RegExp", "value": 34.76361545988257}, {"lowerIsBetter": false, "replicates": [528.8207297726071], "unit": "score", "name": "Splay", "value": 154.099481}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 22995.552318326772}]} 04:49:15 INFO - RETURN: dromaeo_css: 7434.36 04:49:15 INFO - RETURN: kraken: 1470.40 04:49:15 INFO - RETURN: v8_7: 22995.55 04:49:15 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,53,35]]", "result": "22995.55"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,53,35]]", "result": "1470.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,53,35]]", "result": "7434.36"}}} 04:49:15 INFO - Return code: 0 04:49:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 04:49:16 INFO - # TBPL SUCCESS # 04:49:16 INFO - Running post-action listener: _resource_record_post_action 04:49:16 INFO - Running post-run listener: _resource_record_post_run 04:49:17 INFO - Total resource usage - Wall time: 1224s; CPU: 13.0%; Read bytes: 315392; Write bytes: 514514944; Read time: 44; Write time: 1085360 04:49:17 INFO - install - Wall time: 15s; CPU: 19.0%; Read bytes: 0; Write bytes: 251736064; Read time: 0; Write time: 769840 04:49:17 INFO - run-tests - Wall time: 1210s; CPU: 13.0%; Read bytes: 315392; Write bytes: 262778880; Read time: 44; Write time: 315520 04:49:17 INFO - Running post-run listener: _upload_blobber_files 04:49:17 INFO - Blob upload gear active. 04:49:17 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 04:49:17 INFO - Copying logs to upload dir... 04:49:17 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1257.677191 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-02-16 04:49:16.240029) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-02-16 04:49:16.243235) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1455625270.900196-363091807 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455617390/firefox-45.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010014 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455617390/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-16 04:49:16.293567) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-16 04:49:16.293894) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1455625270.900196-363091807 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004673 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-16 04:49:16.343562) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-16 04:49:16.343881) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-16 04:49:16.344160) ========= ========= Total master_lag: 0.39 =========