builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-059 starttime: 1453912272.47 results: success (0) buildid: 20160127060723 builduid: fa550f90676b40c088614af50acf0071 revision: 76fdbc5ce8ea ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-27 08:31:12.470338) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-27 08:31:12.470900) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-27 08:31:12.471196) ========= 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=3a3620fb28aea1604ab609ef000001d2-1453912263.448922-1594766415 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006368 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-27 08:31:12.509937) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-27 08:31:12.510562) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-27 08:31:12.570090) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-27 08:31:12.570567) ========= 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=3a3620fb28aea1604ab609ef000001d2-1453912263.448922-1594766415 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004570 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-27 08:31:12.623243) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-27 08:31:12.623754) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-27 08:31:12.624331) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-27 08:31:12.624714) ========= 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=3a3620fb28aea1604ab609ef000001d2-1453912263.448922-1594766415 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-27 08:31:13-- 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% 222M=0s 2016-01-27 08:31:13 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.133540 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-27 08:31:12.774781) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-27 08:31:12.775249) ========= 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=3a3620fb28aea1604ab609ef000001d2-1453912263.448922-1594766415 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014849 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-27 08:31:12.828363) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-27 08:31:12.828712) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 76fdbc5ce8ea --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 76fdbc5ce8ea --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=3a3620fb28aea1604ab609ef000001d2-1453912263.448922-1594766415 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-27 08:31:13,300 Setting DEBUG logging. 2016-01-27 08:31:13,300 attempt 1/10 2016-01-27 08:31:13,300 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/76fdbc5ce8ea?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-27 08:31:13,644 unpacking tar archive at: mozilla-beta-76fdbc5ce8ea/testing/mozharness/ program finished with exit code 0 elapsedTime=0.623049 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-27 08:31:13.464346) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-27 08:31:13.464693) ========= echo 76fdbc5ce8ea in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'76fdbc5ce8ea'] 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=3a3620fb28aea1604ab609ef000001d2-1453912263.448922-1594766415 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 76fdbc5ce8ea program finished with exit code 0 elapsedTime=0.003345 script_repo_revision: '76fdbc5ce8ea' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-27 08:31:13.511847) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-27 08:31:13.512167) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-27 08:31:13.524686) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-01-27 08:31:13.524979) ========= /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=3a3620fb28aea1604ab609ef000001d2-1453912263.448922-1594766415 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:31:14 INFO - MultiFileLogger online at 20160127 08:31:14 in /builds/slave/test-pgo 08:31:14 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 08:31:14 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 08:31:14 INFO - {'append_to_log': False, 08:31:14 INFO - 'base_work_dir': '/builds/slave/test-pgo', 08:31:14 INFO - 'blob_upload_branch': 'Mozilla-Beta', 08:31:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 08:31:14 INFO - 'branch': 'Mozilla-Beta', 08:31:14 INFO - 'buildbot_json_path': 'buildprops.json', 08:31:14 INFO - 'config_files': ('talos/linux_config.py',), 08:31:14 INFO - 'default_actions': ('clobber', 08:31:14 INFO - 'read-buildbot-config', 08:31:14 INFO - 'download-and-extract', 08:31:14 INFO - 'populate-webroot', 08:31:14 INFO - 'create-virtualenv', 08:31:14 INFO - 'install', 08:31:14 INFO - 'run-tests'), 08:31:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:31:14 INFO - 'download_minidump_stackwalk': True, 08:31:14 INFO - 'download_symbols': 'ondemand', 08:31:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:31:14 INFO - 'tooltool.py': '/tools/tooltool.py', 08:31:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:31:14 INFO - '/tools/misc-python/virtualenv.py')}, 08:31:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:31:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:31:14 INFO - 'installer_path': 'installer.exe', 08:31:14 INFO - 'log_level': 'info', 08:31:14 INFO - 'log_name': 'talos', 08:31:14 INFO - 'log_to_console': True, 08:31:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:31:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:31:14 INFO - 'opt_config_files': (), 08:31:14 INFO - 'pip_index': False, 08:31:14 INFO - 'sps_profile': False, 08:31:14 INFO - 'sps_profile_interval': 0, 08:31:14 INFO - 'suite': 'dromaeojs', 08:31:14 INFO - 'system_bits': '32', 08:31:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:31:14 INFO - 'title': 'talos-linux64-ix-059', 08:31:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:31:14 INFO - 'use_talos_json': True, 08:31:14 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 08:31:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:31:14 INFO - 'work_dir': 'build'} 08:31:14 INFO - ##### 08:31:14 INFO - ##### Running clobber step. 08:31:14 INFO - ##### 08:31:14 INFO - Running pre-action listener: _resource_record_pre_action 08:31:14 INFO - Running main action method: clobber 08:31:14 INFO - rmtree: /builds/slave/test-pgo/build 08:31:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 08:31:15 INFO - Running post-action listener: _resource_record_post_action 08:31:15 INFO - ##### 08:31:15 INFO - ##### Running read-buildbot-config step. 08:31:15 INFO - ##### 08:31:15 INFO - Running pre-action listener: _resource_record_pre_action 08:31:15 INFO - Running main action method: read_buildbot_config 08:31:15 INFO - Using buildbot properties: 08:31:15 INFO - { 08:31:15 INFO - "properties": { 08:31:15 INFO - "buildnumber": 89, 08:31:15 INFO - "product": "firefox", 08:31:15 INFO - "script_repo_revision": "production", 08:31:15 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 08:31:15 INFO - "repository": "", 08:31:15 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 08:31:15 INFO - "buildid": "20160127060723", 08:31:15 INFO - "slavename": "talos-linux64-ix-059", 08:31:15 INFO - "pgo_build": "True", 08:31:15 INFO - "basedir": "/builds/slave/test-pgo", 08:31:15 INFO - "project": "", 08:31:15 INFO - "platform": "ubuntu64_hw", 08:31:15 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:31:15 INFO - "slavebuilddir": "test", 08:31:15 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 08:31:15 INFO - "branch": "mozilla-beta", 08:31:15 INFO - "repo_path": "releases/mozilla-beta", 08:31:15 INFO - "stage_platform": "linux64-pgo", 08:31:15 INFO - "builduid": "fa550f90676b40c088614af50acf0071", 08:31:15 INFO - "revision": "76fdbc5ce8ea" 08:31:15 INFO - }, 08:31:15 INFO - "sourcestamp": { 08:31:15 INFO - "repository": "", 08:31:15 INFO - "hasPatch": false, 08:31:15 INFO - "project": "", 08:31:15 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 08:31:15 INFO - "changes": [ 08:31:15 INFO - { 08:31:15 INFO - "category": null, 08:31:15 INFO - "files": [ 08:31:15 INFO - { 08:31:15 INFO - "url": null, 08:31:15 INFO - "name": "http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453903643/firefox-45.0.en-US.linux-x86_64.tar.bz2" 08:31:15 INFO - } 08:31:15 INFO - ], 08:31:15 INFO - "repository": "", 08:31:15 INFO - "rev": "76fdbc5ce8ea", 08:31:15 INFO - "who": "sendchange", 08:31:15 INFO - "when": 1453912264, 08:31:15 INFO - "number": 7525053, 08:31:15 INFO - "comments": "Bug 1243363 - Add rust to beta and release mozconfigs. r=rail a=Sylvestre", 08:31:15 INFO - "project": "", 08:31:15 INFO - "at": "Wed 27 Jan 2016 08:31:04", 08:31:15 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 08:31:15 INFO - "revlink": "", 08:31:15 INFO - "properties": [ 08:31:15 INFO - [ 08:31:15 INFO - "buildid", 08:31:15 INFO - "20160127060723", 08:31:15 INFO - "Change" 08:31:15 INFO - ], 08:31:15 INFO - [ 08:31:15 INFO - "builduid", 08:31:15 INFO - "fa550f90676b40c088614af50acf0071", 08:31:15 INFO - "Change" 08:31:15 INFO - ], 08:31:15 INFO - [ 08:31:15 INFO - "pgo_build", 08:31:15 INFO - "True", 08:31:15 INFO - "Change" 08:31:15 INFO - ] 08:31:15 INFO - ], 08:31:15 INFO - "revision": "76fdbc5ce8ea" 08:31:15 INFO - } 08:31:15 INFO - ], 08:31:15 INFO - "revision": "76fdbc5ce8ea" 08:31:15 INFO - } 08:31:15 INFO - } 08:31:15 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453903643/firefox-45.0.en-US.linux-x86_64.tar.bz2. 08:31:15 INFO - Running post-action listener: _resource_record_post_action 08:31:15 INFO - ##### 08:31:15 INFO - ##### Running download-and-extract step. 08:31:15 INFO - ##### 08:31:15 INFO - Running pre-action listener: _resource_record_pre_action 08:31:15 INFO - Running main action method: download_and_extract 08:31:15 INFO - mkdir: /builds/slave/test-pgo/build/tests 08:31:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:31:15 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453903643/test_packages.json 08:31:15 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453903643/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 08:31:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453903643/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 08:31:15 INFO - Downloaded 1270 bytes. 08:31:15 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 08:31:15 INFO - Using the following test package requirements: 08:31:15 INFO - {u'common': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 08:31:15 INFO - u'cppunittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 08:31:15 INFO - u'firefox-45.0.en-US.linux-x86_64.cppunittest.tests.zip'], 08:31:15 INFO - u'jittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 08:31:15 INFO - u'jsshell-linux-x86_64.zip'], 08:31:15 INFO - u'mochitest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 08:31:15 INFO - u'firefox-45.0.en-US.linux-x86_64.mochitest.tests.zip'], 08:31:15 INFO - u'mozbase': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 08:31:15 INFO - u'reftest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 08:31:15 INFO - u'firefox-45.0.en-US.linux-x86_64.reftest.tests.zip'], 08:31:15 INFO - u'talos': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 08:31:15 INFO - u'firefox-45.0.en-US.linux-x86_64.talos.tests.zip'], 08:31:15 INFO - u'web-platform': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 08:31:15 INFO - u'firefox-45.0.en-US.linux-x86_64.web-platform.tests.zip'], 08:31:15 INFO - u'webapprt': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 08:31:15 INFO - u'xpcshell': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 08:31:15 INFO - u'firefox-45.0.en-US.linux-x86_64.xpcshell.tests.zip']} 08:31:15 INFO - Downloading packages: [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:31:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:31:15 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453903643/firefox-45.0.en-US.linux-x86_64.common.tests.zip 08:31:15 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453903643/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 08:31:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453903643/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 08:31:17 INFO - Downloaded 21581347 bytes. 08:31:17 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 08:31:17 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 08:31:17 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 08:31:18 INFO - Return code: 0 08:31:18 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 08:31:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:31:18 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453903643/firefox-45.0.en-US.linux-x86_64.common.tests.zip 08:31:18 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453903643/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 08:31:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453903643/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 08:31:19 INFO - Downloaded 21581347 bytes. 08:31:19 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 08:31:19 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 08:31:19 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 08:31:20 INFO - Return code: 0 08:31: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')]} 08:31:20 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453903643/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 08:31:20 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453903643/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 08:31:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453903643/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 08:31:25 INFO - Downloaded 11132038 bytes. 08:31: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 08:31:25 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 08:31: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 08:31:26 INFO - Return code: 0 08:31: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')]} 08:31:26 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453903643/firefox-45.0.en-US.linux-x86_64.tar.bz2 08:31:26 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453903643/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 08:31:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453903643/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 08:31:30 INFO - Downloaded 57945145 bytes. 08:31:30 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453903643/firefox-45.0.en-US.linux-x86_64.tar.bz2 08:31:30 INFO - mkdir: /builds/slave/test-pgo/properties 08:31:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 08:31:30 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 08:31:30 INFO - Contents: 08:31:30 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453903643/firefox-45.0.en-US.linux-x86_64.tar.bz2 08:31:30 INFO - Running post-action listener: _resource_record_post_action 08:31:30 INFO - Running post-action listener: set_extra_try_arguments 08:31:30 INFO - ##### 08:31:30 INFO - ##### Running populate-webroot step. 08:31:30 INFO - ##### 08:31:30 INFO - Running pre-action listener: _resource_record_pre_action 08:31:30 INFO - Running main action method: populate_webroot 08:31:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:31:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:31:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:31:30 INFO - '--tppagecycles', 08:31:30 INFO - '7'], 08:31:30 INFO - 'tests': ['tsvgm']}}, 08:31:30 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:31:30 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:31:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:31:30 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:31:30 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:31:30 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:31:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:31:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:31:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:31:30 INFO - 'talos_options': ['--e10s'], 08:31:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:31:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:31:30 INFO - 'tests': ['damp', 'tps']}, 08:31:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:31:30 INFO - 'talos_options': ['--e10s'], 08:31:30 INFO - 'tests': ['damp', 'tps']}, 08:31:30 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:31:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:31:30 INFO - 'other': {'tests': ['a11yr', 08:31:30 INFO - 'ts_paint', 08:31:30 INFO - 'tpaint', 08:31:30 INFO - 'sessionrestore', 08:31:30 INFO - 'sessionrestore_no_auto_restore']}, 08:31:30 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:31:30 INFO - 'tests': ['a11yr', 08:31:30 INFO - 'ts_paint', 08:31:30 INFO - 'tpaint', 08:31:30 INFO - 'sessionrestore', 08:31:30 INFO - 'sessionrestore_no_auto_restore']}, 08:31:30 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:31:30 INFO - 'tests': ['a11yr', 08:31:30 INFO - 'ts_paint', 08:31:30 INFO - 'tpaint', 08:31:30 INFO - 'sessionrestore', 08:31:30 INFO - 'sessionrestore_no_auto_restore']}, 08:31:30 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:31:30 INFO - 'tests': ['a11yr', 08:31:30 INFO - 'ts_paint', 08:31:30 INFO - 'tpaint', 08:31:30 INFO - 'sessionrestore', 08:31:30 INFO - 'sessionrestore_no_auto_restore']}, 08:31:30 INFO - 'other_l64': {'tests': ['a11yr', 08:31:30 INFO - 'ts_paint', 08:31:30 INFO - 'tpaint', 08:31:30 INFO - 'sessionrestore', 08:31:30 INFO - 'sessionrestore_no_auto_restore']}, 08:31:30 INFO - 'other_nol64': {'tests': ['a11yr', 08:31:30 INFO - 'ts_paint', 08:31:30 INFO - 'tpaint', 08:31:30 INFO - 'sessionrestore', 08:31:30 INFO - 'sessionrestore_no_auto_restore']}, 08:31:30 INFO - 'svgr': {'tests': ['tsvgx', 08:31:30 INFO - 'tsvgr_opacity', 08:31:30 INFO - 'tart', 08:31:30 INFO - 'tscrollx', 08:31:30 INFO - 'cart']}, 08:31:30 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:31:30 INFO - 'tests': ['tsvgx', 08:31:30 INFO - 'tsvgr_opacity', 08:31:30 INFO - 'tart', 08:31:30 INFO - 'tscrollx', 08:31:30 INFO - 'cart']}, 08:31:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:31:30 INFO - 'tests': ['tp5o']}, 08:31:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:31:30 INFO - 'talos_options': ['--e10s'], 08:31:30 INFO - 'tests': ['tp5o']}, 08:31:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:31:30 INFO - 'talos_options': ['--xperf_path', 08:31:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:31:30 INFO - 'tests': ['tp5n']}, 08:31:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:31:30 INFO - 'talos_options': ['--e10s', 08:31:30 INFO - '--xperf_path', 08:31:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:31:30 INFO - 'tests': ['tp5n']}}, 08:31:30 INFO - 'talos.zip': {'path': '', 08:31:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:31:30 INFO - Running post-action listener: _resource_record_post_action 08:31:30 INFO - ##### 08:31:30 INFO - ##### Running create-virtualenv step. 08:31:30 INFO - ##### 08:31:30 INFO - Running pre-action listener: _resource_record_pre_action 08:31:30 INFO - Running main action method: create_virtualenv 08:31:30 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 08:31:30 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 08:31:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 08:31:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:31:30 INFO - Using real prefix '/usr' 08:31:30 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 08:31:31 INFO - Installing distribute.............................................................................................................................................................................................done. 08:31:33 INFO - Installing pip.................done. 08:31:33 INFO - Return code: 0 08:31:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 08:31:33 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')]} 08:31:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:31:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:33 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')]} 08:31:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:31:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:33 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 0x7f545c123f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x221f600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ae350>, '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 0x22af250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22af6e0>, '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': '3a3620fb28aea1604ab609ef000001d2-1453912263.448922-1594766415', '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 08:31:33 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 08:31:33 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 08:31:33 INFO - Using env: {'DISPLAY': ':0', 08:31:33 INFO - 'HOME': '/home/cltbld', 08:31:33 INFO - 'LANG': 'en_US.UTF-8', 08:31:33 INFO - 'LANGUAGE': 'en_US:en', 08:31:33 INFO - 'LOGNAME': 'cltbld', 08:31:33 INFO - 'MAIL': '/var/mail/cltbld', 08:31:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:31:33 INFO - 'MOZ_NO_REMOTE': '1', 08:31:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:31:33 INFO - 'NO_EM_RESTART': '1', 08:31:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:31:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:31:33 INFO - 'PWD': '/builds/slave/test-pgo', 08:31:33 INFO - 'SHELL': '/bin/bash', 08:31:33 INFO - 'SHLVL': '1', 08:31:33 INFO - 'TERM': 'linux', 08:31:33 INFO - 'TMOUT': '86400', 08:31:33 INFO - 'USER': 'cltbld', 08:31:33 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1453912263.448922-1594766415', 08:31:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:31:33 INFO - '_': '/tools/buildbot/bin/python'} 08:31:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:31:33 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 08:31:33 INFO - Cleaning up... 08:31:33 INFO - Return code: 0 08:31:33 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 08:31:33 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')]} 08:31:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:31:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:33 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')]} 08:31:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:31:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:33 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 0x7f545c123f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x221f600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ae350>, '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 0x22af250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22af6e0>, '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': '3a3620fb28aea1604ab609ef000001d2-1453912263.448922-1594766415', '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 08:31:33 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 08:31:33 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 08:31:33 INFO - Using env: {'DISPLAY': ':0', 08:31:33 INFO - 'HOME': '/home/cltbld', 08:31:33 INFO - 'LANG': 'en_US.UTF-8', 08:31:33 INFO - 'LANGUAGE': 'en_US:en', 08:31:33 INFO - 'LOGNAME': 'cltbld', 08:31:33 INFO - 'MAIL': '/var/mail/cltbld', 08:31:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:31:33 INFO - 'MOZ_NO_REMOTE': '1', 08:31:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:31:33 INFO - 'NO_EM_RESTART': '1', 08:31:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:31:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:31:33 INFO - 'PWD': '/builds/slave/test-pgo', 08:31:33 INFO - 'SHELL': '/bin/bash', 08:31:33 INFO - 'SHLVL': '1', 08:31:33 INFO - 'TERM': 'linux', 08:31:33 INFO - 'TMOUT': '86400', 08:31:33 INFO - 'USER': 'cltbld', 08:31:33 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1453912263.448922-1594766415', 08:31:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:31:33 INFO - '_': '/tools/buildbot/bin/python'} 08:31:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:31:33 INFO - Downloading/unpacking psutil>=0.7.1 08:31: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 08:31: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 08:31: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 08:31: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 08:31: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 08:31: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 08:31:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 08:31:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:31:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:31:35 INFO - Installing collected packages: psutil 08:31:35 INFO - Running setup.py install for psutil 08:31:35 INFO - building 'psutil._psutil_linux' extension 08:31:35 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 08:31:35 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 08:31:35 INFO - building 'psutil._psutil_posix' extension 08:31:35 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 08:31:35 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 08:31:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:31:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:31:36 INFO - Successfully installed psutil 08:31:36 INFO - Cleaning up... 08:31:36 INFO - Return code: 0 08:31:36 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 08:31:36 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')]} 08:31:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:31:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:36 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')]} 08:31:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:31:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:36 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 0x7f545c123f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x221f600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ae350>, '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 0x22af250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22af6e0>, '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': '3a3620fb28aea1604ab609ef000001d2-1453912263.448922-1594766415', '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 08:31:36 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 08:31:36 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 08:31:36 INFO - Using env: {'DISPLAY': ':0', 08:31:36 INFO - 'HOME': '/home/cltbld', 08:31:36 INFO - 'LANG': 'en_US.UTF-8', 08:31:36 INFO - 'LANGUAGE': 'en_US:en', 08:31:36 INFO - 'LOGNAME': 'cltbld', 08:31:36 INFO - 'MAIL': '/var/mail/cltbld', 08:31:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:31:36 INFO - 'MOZ_NO_REMOTE': '1', 08:31:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:31:36 INFO - 'NO_EM_RESTART': '1', 08:31:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:31:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:31:36 INFO - 'PWD': '/builds/slave/test-pgo', 08:31:36 INFO - 'SHELL': '/bin/bash', 08:31:36 INFO - 'SHLVL': '1', 08:31:36 INFO - 'TERM': 'linux', 08:31:36 INFO - 'TMOUT': '86400', 08:31:36 INFO - 'USER': 'cltbld', 08:31:36 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1453912263.448922-1594766415', 08:31:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:31:36 INFO - '_': '/tools/buildbot/bin/python'} 08:31:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:31:36 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:31:36 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 08:31:36 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 08:31:36 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 08:31:36 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 08:31:36 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 08:31:36 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 08:31:38 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:31:38 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:31:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:31:38 INFO - Installing collected packages: mozsystemmonitor 08:31:38 INFO - Running setup.py install for mozsystemmonitor 08:31:38 INFO - Successfully installed mozsystemmonitor 08:31:38 INFO - Cleaning up... 08:31:38 INFO - Return code: 0 08:31:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 08:31: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')]} 08:31:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:31:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31: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')]} 08:31:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:31:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:38 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 0x7f545c123f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x221f600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ae350>, '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 0x22af250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22af6e0>, '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': '3a3620fb28aea1604ab609ef000001d2-1453912263.448922-1594766415', '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 08:31:38 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 08:31:38 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 08:31:38 INFO - Using env: {'DISPLAY': ':0', 08:31:38 INFO - 'HOME': '/home/cltbld', 08:31:38 INFO - 'LANG': 'en_US.UTF-8', 08:31:38 INFO - 'LANGUAGE': 'en_US:en', 08:31:38 INFO - 'LOGNAME': 'cltbld', 08:31:38 INFO - 'MAIL': '/var/mail/cltbld', 08:31:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:31:38 INFO - 'MOZ_NO_REMOTE': '1', 08:31:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:31:38 INFO - 'NO_EM_RESTART': '1', 08:31:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:31:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:31:38 INFO - 'PWD': '/builds/slave/test-pgo', 08:31:38 INFO - 'SHELL': '/bin/bash', 08:31:38 INFO - 'SHLVL': '1', 08:31:38 INFO - 'TERM': 'linux', 08:31:38 INFO - 'TMOUT': '86400', 08:31:38 INFO - 'USER': 'cltbld', 08:31:38 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1453912263.448922-1594766415', 08:31:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:31:38 INFO - '_': '/tools/buildbot/bin/python'} 08:31:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:31:38 INFO - Downloading/unpacking blobuploader==1.2.4 08:31:38 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 08:31:38 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 08:31:38 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 08:31:38 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 08:31:38 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 08:31:38 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 08:31:40 INFO - Downloading blobuploader-1.2.4.tar.gz 08:31:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:31:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:31:40 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 08:31:40 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 08:31:40 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 08:31:40 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 08:31:40 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 08:31:40 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 08:31:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 08:31:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:31:40 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 08:31:40 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 08:31:40 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 08:31:40 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 08:31:40 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 08:31:40 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 08:31:41 INFO - Downloading docopt-0.6.1.tar.gz 08:31:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 08:31:41 INFO - Installing collected packages: blobuploader, requests, docopt 08:31:41 INFO - Running setup.py install for blobuploader 08:31:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:31:41 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 08:31:41 INFO - Running setup.py install for requests 08:31:41 INFO - Running setup.py install for docopt 08:31:41 INFO - Successfully installed blobuploader requests docopt 08:31:41 INFO - Cleaning up... 08:31:41 INFO - Return code: 0 08:31:41 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:31: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')]} 08:31:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:31:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31: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')]} 08:31:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:31:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:41 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 0x7f545c123f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x221f600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ae350>, '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 0x22af250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22af6e0>, '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': '3a3620fb28aea1604ab609ef000001d2-1453912263.448922-1594766415', '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 08:31:41 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 08:31:41 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 08:31:41 INFO - Using env: {'DISPLAY': ':0', 08:31:41 INFO - 'HOME': '/home/cltbld', 08:31:41 INFO - 'LANG': 'en_US.UTF-8', 08:31:41 INFO - 'LANGUAGE': 'en_US:en', 08:31:41 INFO - 'LOGNAME': 'cltbld', 08:31:41 INFO - 'MAIL': '/var/mail/cltbld', 08:31:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:31:41 INFO - 'MOZ_NO_REMOTE': '1', 08:31:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:31:41 INFO - 'NO_EM_RESTART': '1', 08:31:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:31:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:31:41 INFO - 'PWD': '/builds/slave/test-pgo', 08:31:41 INFO - 'SHELL': '/bin/bash', 08:31:41 INFO - 'SHLVL': '1', 08:31:41 INFO - 'TERM': 'linux', 08:31:41 INFO - 'TMOUT': '86400', 08:31:41 INFO - 'USER': 'cltbld', 08:31:41 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1453912263.448922-1594766415', 08:31:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:31:41 INFO - '_': '/tools/buildbot/bin/python'} 08:31:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:31:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:31:41 INFO - Running setup.py (path:/tmp/pip-6sWgJJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:31:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:31:42 INFO - Running setup.py (path:/tmp/pip-uaOuQb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:31:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:31:42 INFO - Running setup.py (path:/tmp/pip-jf4mb4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:31:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:31:42 INFO - Running setup.py (path:/tmp/pip-z2gVIU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:31:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 08:31:42 INFO - Running setup.py (path:/tmp/pip-l1V24k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 08:31:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:31:42 INFO - Running setup.py (path:/tmp/pip-_bYrmR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:31:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:31:42 INFO - Running setup.py (path:/tmp/pip-tEAQfg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:31:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:31:42 INFO - Running setup.py (path:/tmp/pip-_gqP8E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:31:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 08:31:42 INFO - Running setup.py (path:/tmp/pip-U__Kuz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 08:31:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 08:31:42 INFO - Running setup.py (path:/tmp/pip-vFulFl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 08:31:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:31:42 INFO - Running setup.py (path:/tmp/pip-lGYAMj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:31:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:31:42 INFO - Running setup.py (path:/tmp/pip-0I_77A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:31:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:31:42 INFO - Running setup.py (path:/tmp/pip-RrearY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:31:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:31:42 INFO - Running setup.py (path:/tmp/pip-8d8tOr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:31:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:31:42 INFO - Running setup.py (path:/tmp/pip-HnWnaV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:31:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 08:31:43 INFO - Running setup.py (path:/tmp/pip-FqkUs8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 08:31:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 08:31:43 INFO - Running setup.py (path:/tmp/pip-0J4J9f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 08:31:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:31:43 INFO - Running setup.py install for manifestparser 08:31:43 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 08:31:43 INFO - Running setup.py install for mozcrash 08:31:43 INFO - Running setup.py install for mozdebug 08:31:43 INFO - Running setup.py install for mozdevice 08:31:43 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 08:31:43 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 08:31:43 INFO - Running setup.py install for mozfile 08:31:43 INFO - Running setup.py install for mozhttpd 08:31:43 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 08:31:43 INFO - Running setup.py install for mozinfo 08:31:43 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 08:31:43 INFO - Running setup.py install for mozInstall 08:31:43 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 08:31:43 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 08:31:43 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 08:31:43 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 08:31:43 INFO - Running setup.py install for mozleak 08:31:44 INFO - Running setup.py install for mozlog 08:31:44 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 08:31:44 INFO - Running setup.py install for moznetwork 08:31:44 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 08:31:44 INFO - Running setup.py install for mozprocess 08:31:44 INFO - Running setup.py install for mozprofile 08:31:44 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 08:31:44 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 08:31:44 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 08:31:44 INFO - Running setup.py install for mozrunner 08:31:44 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 08:31:44 INFO - Running setup.py install for mozscreenshot 08:31:44 INFO - Running setup.py install for moztest 08:31:44 INFO - Running setup.py install for mozversion 08:31:44 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 08:31:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:31:44 INFO - Cleaning up... 08:31:44 INFO - Return code: 0 08:31:44 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:31:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:31:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:31:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:31:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:31:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:44 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 0x7f545c123f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x221f600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ae350>, '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 0x22af250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22af6e0>, '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': '3a3620fb28aea1604ab609ef000001d2-1453912263.448922-1594766415', '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 08:31:44 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 08:31:44 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 08:31:44 INFO - Using env: {'DISPLAY': ':0', 08:31:44 INFO - 'HOME': '/home/cltbld', 08:31:44 INFO - 'LANG': 'en_US.UTF-8', 08:31:44 INFO - 'LANGUAGE': 'en_US:en', 08:31:44 INFO - 'LOGNAME': 'cltbld', 08:31:44 INFO - 'MAIL': '/var/mail/cltbld', 08:31:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:31:44 INFO - 'MOZ_NO_REMOTE': '1', 08:31:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:31:44 INFO - 'NO_EM_RESTART': '1', 08:31:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:31:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:31:44 INFO - 'PWD': '/builds/slave/test-pgo', 08:31:44 INFO - 'SHELL': '/bin/bash', 08:31:44 INFO - 'SHLVL': '1', 08:31:44 INFO - 'TERM': 'linux', 08:31:44 INFO - 'TMOUT': '86400', 08:31:44 INFO - 'USER': 'cltbld', 08:31:44 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1453912263.448922-1594766415', 08:31:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:31:44 INFO - '_': '/tools/buildbot/bin/python'} 08:31:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:31:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:31:45 INFO - Running setup.py (path:/tmp/pip-6hft3U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:31:45 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)) 08:31:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:31:45 INFO - Running setup.py (path:/tmp/pip-nVZjZd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:31:45 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)) 08:31:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:31:45 INFO - Running setup.py (path:/tmp/pip-OHiXg0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:31:45 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)) 08:31:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:31:45 INFO - Running setup.py (path:/tmp/pip-42qLdH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:31:45 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)) 08:31:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 08:31:45 INFO - Running setup.py (path:/tmp/pip-5awF1l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 08:31:45 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)) 08:31:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:31:45 INFO - Running setup.py (path:/tmp/pip-Ee4N7N-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:31:45 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)) 08:31:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:31:45 INFO - Running setup.py (path:/tmp/pip-eyRmuA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:31:45 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)) 08:31:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:31:45 INFO - Running setup.py (path:/tmp/pip-IqAD1o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:31:45 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)) 08:31:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 08:31:45 INFO - Running setup.py (path:/tmp/pip-NG_P49-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 08:31:45 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)) 08:31:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 08:31:45 INFO - Running setup.py (path:/tmp/pip-k9106b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 08:31:45 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)) 08:31:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:31:45 INFO - Running setup.py (path:/tmp/pip-IY2HfN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:31:45 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)) 08:31:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:31:46 INFO - Running setup.py (path:/tmp/pip-Yg1ePU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:31:46 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)) 08:31:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:31:46 INFO - Running setup.py (path:/tmp/pip-YFQEzd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:31:46 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)) 08:31:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:31:46 INFO - Running setup.py (path:/tmp/pip-o49dx1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:31:46 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)) 08:31:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:31:46 INFO - Running setup.py (path:/tmp/pip-NX_Ocx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:31:46 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)) 08:31:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 08:31:46 INFO - Running setup.py (path:/tmp/pip-S7XkMS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 08:31:46 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)) 08:31:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 08:31:46 INFO - Running setup.py (path:/tmp/pip-TzkUzB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 08:31:46 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)) 08:31:46 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)) 08:31:46 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)) 08:31:46 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)) 08:31:46 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)) 08:31:46 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)) 08:31:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 08:31:46 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 08:31:46 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 08:31:46 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 08:31:46 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 08:31:46 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 08:31:46 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 08:31:48 INFO - Downloading blessings-1.6.tar.gz 08:31:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 08:31:48 INFO - Installing collected packages: blessings 08:31:48 INFO - Running setup.py install for blessings 08:31:48 INFO - Successfully installed blessings 08:31:48 INFO - Cleaning up... 08:31:48 INFO - Return code: 0 08:31:48 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 08:31:48 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 08:31:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 08:31:48 INFO - Reading from file tmpfile_stdout 08:31:48 INFO - Current package versions: 08:31:48 INFO - argparse == 1.2.1 08:31:48 INFO - blessings == 1.6 08:31:48 INFO - blobuploader == 1.2.4 08:31:48 INFO - docopt == 0.6.1 08:31:48 INFO - manifestparser == 1.1 08:31:48 INFO - mozInstall == 1.12 08:31:48 INFO - mozcrash == 0.16 08:31:48 INFO - mozdebug == 0.1 08:31:48 INFO - mozdevice == 0.47 08:31:48 INFO - mozfile == 1.2 08:31:48 INFO - mozhttpd == 0.7 08:31:48 INFO - mozinfo == 0.9 08:31:48 INFO - mozleak == 0.1 08:31:48 INFO - mozlog == 3.1 08:31:48 INFO - moznetwork == 0.27 08:31:48 INFO - mozprocess == 0.22 08:31:48 INFO - mozprofile == 0.27 08:31:48 INFO - mozrunner == 6.11 08:31:48 INFO - mozscreenshot == 0.1 08:31:48 INFO - mozsystemmonitor == 0.0 08:31:48 INFO - moztest == 0.7 08:31:48 INFO - mozversion == 1.4 08:31:48 INFO - psutil == 3.1.1 08:31:48 INFO - requests == 1.2.3 08:31:48 INFO - wsgiref == 0.1.2 08:31:48 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:31: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')]} 08:31:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:31:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31: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')]} 08:31:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:31:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:48 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 0x7f545c123f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x221f600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ae350>, '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 0x22af250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22af6e0>, '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': '3a3620fb28aea1604ab609ef000001d2-1453912263.448922-1594766415', '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 08:31:48 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 08:31:48 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 08:31:48 INFO - Using env: {'DISPLAY': ':0', 08:31:48 INFO - 'HOME': '/home/cltbld', 08:31:48 INFO - 'LANG': 'en_US.UTF-8', 08:31:48 INFO - 'LANGUAGE': 'en_US:en', 08:31:48 INFO - 'LOGNAME': 'cltbld', 08:31:48 INFO - 'MAIL': '/var/mail/cltbld', 08:31:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:31:48 INFO - 'MOZ_NO_REMOTE': '1', 08:31:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:31:48 INFO - 'NO_EM_RESTART': '1', 08:31:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:31:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:31:48 INFO - 'PWD': '/builds/slave/test-pgo', 08:31:48 INFO - 'SHELL': '/bin/bash', 08:31:48 INFO - 'SHLVL': '1', 08:31:48 INFO - 'TERM': 'linux', 08:31:48 INFO - 'TMOUT': '86400', 08:31:48 INFO - 'USER': 'cltbld', 08:31:48 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1453912263.448922-1594766415', 08:31:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:31:48 INFO - '_': '/tools/buildbot/bin/python'} 08:31:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:31:48 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)) 08:31:48 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)) 08:31:48 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)) 08:31:48 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)) 08:31:48 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)) 08:31:48 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)) 08:31:48 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)) 08:31:48 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)) 08:31:48 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)) 08:31:48 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)) 08:31:48 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)) 08:31:48 INFO - Cleaning up... 08:31:48 INFO - Return code: 0 08:31:48 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 08:31: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')]} 08:31:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:31:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31: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')]} 08:31:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:31:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f545c123f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x221f600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ae350>, '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 0x22af250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22af6e0>, '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': '3a3620fb28aea1604ab609ef000001d2-1453912263.448922-1594766415', '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 08:31: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', 'jsonschema'] in /builds/slave/test-pgo/build 08:31: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 jsonschema 08:31:48 INFO - Using env: {'DISPLAY': ':0', 08:31:48 INFO - 'HOME': '/home/cltbld', 08:31:48 INFO - 'LANG': 'en_US.UTF-8', 08:31:48 INFO - 'LANGUAGE': 'en_US:en', 08:31:48 INFO - 'LOGNAME': 'cltbld', 08:31:48 INFO - 'MAIL': '/var/mail/cltbld', 08:31:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:31:48 INFO - 'MOZ_NO_REMOTE': '1', 08:31:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:31:48 INFO - 'NO_EM_RESTART': '1', 08:31:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:31:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:31:48 INFO - 'PWD': '/builds/slave/test-pgo', 08:31:48 INFO - 'SHELL': '/bin/bash', 08:31:48 INFO - 'SHLVL': '1', 08:31:48 INFO - 'TERM': 'linux', 08:31:48 INFO - 'TMOUT': '86400', 08:31:48 INFO - 'USER': 'cltbld', 08:31:48 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1453912263.448922-1594766415', 08:31:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:31:48 INFO - '_': '/tools/buildbot/bin/python'} 08:31:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:31:49 INFO - Downloading/unpacking jsonschema 08:31:49 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 08:31:49 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 08:31:49 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 08:31:49 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 08:31:49 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 08:31:49 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 08:31:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:31:50 INFO - Downloading/unpacking functools32 (from jsonschema) 08:31: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 08:31: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 08:31: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 08:31: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 08:31: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 08:31: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 08:31:51 INFO - Downloading functools32-3.2.3-2.tar.gz 08:31:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 08:31:51 INFO - warning: no files found matching '*.txt' 08:31:51 INFO - no previously-included directories found matching 'build' 08:31:51 INFO - no previously-included directories found matching 'dist' 08:31:51 INFO - no previously-included directories found matching '.git*' 08:31:51 INFO - Installing collected packages: jsonschema, functools32 08:31:51 INFO - Running setup.py install for functools32 08:31:51 INFO - warning: no files found matching '*.txt' 08:31:51 INFO - no previously-included directories found matching 'build' 08:31:51 INFO - no previously-included directories found matching 'dist' 08:31:51 INFO - no previously-included directories found matching '.git*' 08:31:51 INFO - Successfully installed jsonschema functools32 08:31:51 INFO - Cleaning up... 08:31:51 INFO - Return code: 0 08:31:51 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 08:31:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:31:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:31:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:31:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:31:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:51 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 0x7f545c123f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x221f600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ae350>, '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 0x22af250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22af6e0>, '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': '3a3620fb28aea1604ab609ef000001d2-1453912263.448922-1594766415', '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 08:31:51 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 08:31:51 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 08:31:51 INFO - Using env: {'DISPLAY': ':0', 08:31:51 INFO - 'HOME': '/home/cltbld', 08:31:51 INFO - 'LANG': 'en_US.UTF-8', 08:31:51 INFO - 'LANGUAGE': 'en_US:en', 08:31:51 INFO - 'LOGNAME': 'cltbld', 08:31:51 INFO - 'MAIL': '/var/mail/cltbld', 08:31:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:31:51 INFO - 'MOZ_NO_REMOTE': '1', 08:31:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:31:51 INFO - 'NO_EM_RESTART': '1', 08:31:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:31:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:31:51 INFO - 'PWD': '/builds/slave/test-pgo', 08:31:51 INFO - 'SHELL': '/bin/bash', 08:31:51 INFO - 'SHLVL': '1', 08:31:51 INFO - 'TERM': 'linux', 08:31:51 INFO - 'TMOUT': '86400', 08:31:51 INFO - 'USER': 'cltbld', 08:31:51 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1453912263.448922-1594766415', 08:31:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:31:51 INFO - '_': '/tools/buildbot/bin/python'} 08:31:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:31:51 INFO - Downloading/unpacking flake8 08:31:51 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 08:31:51 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 08:31:51 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 08:31:51 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 08:31:51 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 08:31:51 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 08:31:53 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:31:53 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:31:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:31:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:31:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:31:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:31:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:31:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:31:53 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:31:53 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:31:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:31:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:31:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:31:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:31:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:31:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:31:53 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:31:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:31:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:31:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:31:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:31:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:31:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:31:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 08:31:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:31:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:31:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:31:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:31:54 INFO - no previously-included directories found matching 'docs/_build' 08:31:54 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:31:54 INFO - Running setup.py install for pep8 08:31:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:31:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:31:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:31:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:31:54 INFO - no previously-included directories found matching 'docs/_build' 08:31:54 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 08:31:54 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:31:54 INFO - Cleaning up... 08:31:54 INFO - Return code: 0 08:31:54 INFO - Running post-action listener: _resource_record_post_action 08:31:54 INFO - Running post-action listener: _start_resource_monitoring 08:31:54 INFO - Starting resource monitoring. 08:31:54 INFO - ##### 08:31:54 INFO - ##### Running install step. 08:31:54 INFO - ##### 08:31:54 INFO - Running pre-action listener: _resource_record_pre_action 08:31:54 INFO - Running main action method: install 08:31:54 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 08:31:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 08:31:54 INFO - Reading from file tmpfile_stdout 08:31:54 INFO - Detecting whether we're running mozinstall >=1.0... 08:31:54 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 08:31:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 08:31:54 INFO - Reading from file tmpfile_stdout 08:31:54 INFO - Output received: 08:31:54 INFO - Usage: mozinstall [options] installer 08:31:54 INFO - Options: 08:31:54 INFO - -h, --help show this help message and exit 08:31:54 INFO - -d DEST, --destination=DEST 08:31:54 INFO - Directory to install application into. [default: 08:31:54 INFO - "/builds/slave/test-pgo"] 08:31:54 INFO - --app=APP Application being installed. [default: firefox] 08:31:54 INFO - mkdir: /builds/slave/test-pgo/build/application 08:31:54 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'] 08:31:54 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 08:32:09 INFO - Reading from file tmpfile_stdout 08:32:09 INFO - Output received: 08:32:09 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 08:32:09 INFO - Running post-action listener: _resource_record_post_action 08:32:09 INFO - ##### 08:32:09 INFO - ##### Running run-tests step. 08:32:09 INFO - ##### 08:32:09 INFO - Running pre-action listener: _resource_record_pre_action 08:32:09 INFO - Running main action method: run_tests 08:32:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 08:32:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 08:32:09 INFO - Python 2.7.3 08:32:09 INFO - Return code: 0 08:32:09 INFO - grabbing minidump binary from tooltool 08:32:09 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')]} 08:32:09 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 0x22ae350>, '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 0x22af250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22af6e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 08:32:09 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 08:32:09 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 08:32:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:32:09 INFO - Return code: 0 08:32:09 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 08:32:09 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 08:32:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 08:32:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 08:32:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 08:32:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 08:32:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 08:32:10 INFO - Return code: 0 08:32:10 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/1453903643/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 08:32:10 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/1453903643/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-059 --webServer localhost 08:32:10 INFO - Using env: {'DISPLAY': ':0', 08:32:10 INFO - 'HOME': '/home/cltbld', 08:32:10 INFO - 'LANG': 'en_US.UTF-8', 08:32:10 INFO - 'LANGUAGE': 'en_US:en', 08:32:10 INFO - 'LOGNAME': 'cltbld', 08:32:10 INFO - 'MAIL': '/var/mail/cltbld', 08:32:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 08:32:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 08:32:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:10 INFO - 'MOZ_NO_REMOTE': '1', 08:32:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 08:32:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:32:10 INFO - 'NO_EM_RESTART': '1', 08:32:10 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:32:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:32:10 INFO - 'PWD': '/builds/slave/test-pgo', 08:32:10 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 08:32:10 INFO - 'SHELL': '/bin/bash', 08:32:10 INFO - 'SHLVL': '1', 08:32:10 INFO - 'TERM': 'linux', 08:32:10 INFO - 'TMOUT': '86400', 08:32:10 INFO - 'USER': 'cltbld', 08:32:10 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1453912263.448922-1594766415', 08:32:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:10 INFO - '_': '/tools/buildbot/bin/python'} 08:32:10 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/1453903643/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--webServer', 'localhost'] with output_timeout 3600 08:32:10 INFO - mozversion INFO | application_buildid: 20160127060723 08:32:10 INFO - mozversion INFO | application_changeset: 76fdbc5ce8ea50073d7a72f06f8c00d51c6963eb 08:32:10 INFO - mozversion INFO | application_display_name: Nightly 08:32:10 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:32:10 INFO - mozversion INFO | application_name: Firefox 08:32:10 INFO - mozversion INFO | application_remotingname: firefox 08:32:10 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-beta 08:32:10 INFO - mozversion INFO | application_vendor: Mozilla 08:32:10 INFO - mozversion INFO | application_version: 45.0 08:32:10 INFO - mozversion INFO | platform_buildid: 20160127060723 08:32:10 INFO - mozversion INFO | platform_changeset: 76fdbc5ce8ea50073d7a72f06f8c00d51c6963eb 08:32:10 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-beta 08:32:10 INFO - mozversion INFO | platform_version: 45.0 08:32:10 INFO - 2016-01-27 08:32:10,446 DEBUG : using testdate: 1453912330 08:32:10 INFO - 2016-01-27 08:32:10,446 DEBUG : actual date: 1453912330 08:32:10 INFO - 2016-01-27 08:32:10,454 INFO : starting webserver on 'localhost:48655' 08:32:10 INFO - 2016-01-27 08:32:10,456 INFO : Starting test suite talos-linux64-ix-059 08:32:10 INFO - 2016-01-27 08:32:10,456 INFO : Starting test dromaeo_css 08:32:10 INFO - 2016-01-27 08:32:10,456 DEBUG : operating with platform_type : linux_ 08:32:10 INFO - 2016-01-27 08:32:10,457 INFO : Initialising browser for dromaeo_css test... 08:32:10 INFO - 2016-01-27 08:32:10,473 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpe3VLC7/profile http://localhost:48655/getInfo.html 08:32:14 INFO - 2016-01-27 08:32:14,196 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:32:14 INFO - 2016-01-27 08:32:14,196 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:32:14 INFO - 2016-01-27 08:32:14,196 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 08:32:14 INFO - 2016-01-27 08:32:14,196 DEBUG : BROWSER_OUTPUT: __metrics 08:32:14 INFO - 2016-01-27 08:32:14,338 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] 08:32:14 INFO - 2016-01-27 08:32:14,943 INFO : Browser initialized. 08:32:14 INFO - 2016-01-27 08:32:14,943 INFO : Running cycle 1/1 for dromaeo_css test... 08:32:14 INFO - 2016-01-27 08:32:14,944 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpe3VLC7/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:32:26 INFO - 2016-01-27 08:32:26,721 DEBUG : BROWSER_OUTPUT: RSS: Main: 134619136 08:32:26 INFO - 2016-01-27 08:32:26,721 DEBUG : BROWSER_OUTPUT: 08:33:17 INFO - 2016-01-27 08:33:17,536 DEBUG : BROWSER_OUTPUT: 1453912397533 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] 08:35:25 INFO - 2016-01-27 08:35:25,683 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48655/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48655/tests/dromaeo/cssquery-ext.html) 08:35:26 INFO - 2016-01-27 08:35:26,648 DEBUG : BROWSER_OUTPUT: RSS: Main: 225116160 08:35:26 INFO - 2016-01-27 08:35:26,648 DEBUG : BROWSER_OUTPUT: 08:38:28 INFO - 2016-01-27 08:38:28,603 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48655/tests/dromaeo/cssquery-ext.html (next: http://localhost:48655/tests/dromaeo/cssquery-jquery.html) 08:38:29 INFO - 2016-01-27 08:38:29,169 DEBUG : BROWSER_OUTPUT: RSS: Main: 212025344 08:38:29 INFO - 2016-01-27 08:38:29,169 DEBUG : BROWSER_OUTPUT: 08:41:30 INFO - 2016-01-27 08:41:30,959 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48655/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48655/tests/dromaeo/cssquery-mootools.html) 08:41:31 INFO - 2016-01-27 08:41:31,520 DEBUG : BROWSER_OUTPUT: RSS: Main: 214003712 08:41:31 INFO - 2016-01-27 08:41:31,520 DEBUG : BROWSER_OUTPUT: 08:44:33 INFO - 2016-01-27 08:44:33,215 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48655/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48655/tests/dromaeo/cssquery-prototype.html) 08:44:33 INFO - 2016-01-27 08:44:33,776 DEBUG : BROWSER_OUTPUT: RSS: Main: 201170944 08:44:33 INFO - 2016-01-27 08:44:33,777 DEBUG : BROWSER_OUTPUT: 08:47:36 INFO - 2016-01-27 08:47:36,135 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48655/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48655/tests/dromaeo/cssquery-yui.html) 08:47:36 INFO - 2016-01-27 08:47:36,699 DEBUG : BROWSER_OUTPUT: RSS: Main: 199925760 08:47:36 INFO - 2016-01-27 08:47:36,700 DEBUG : BROWSER_OUTPUT: 08:50:38 INFO - 2016-01-27 08:50:38,703 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48655/tests/dromaeo/cssquery-yui.html (next: http://localhost:48655/tests/dromaeo/cssquery-dojo.html) 08:50:38 INFO - 2016-01-27 08:50:38,953 DEBUG : BROWSER_OUTPUT: RSS: Main: 241868800 08:50:38 INFO - 2016-01-27 08:50:38,953 DEBUG : BROWSER_OUTPUT: 08:50:38 INFO - 2016-01-27 08:50:38,953 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:50:38 INFO - 2016-01-27 08:50:38,954 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:50:38 INFO - 2016-01-27 08:50:38,954 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:50:38 INFO - 2016-01-27 08:50:38,954 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:50:38 INFO - 2016-01-27 08:50:38,954 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3338.298957218984;3343.648916863729;3421.7091547218483;3442.827858607069;3459.2043829919116;5584.050711379065;5604.187392828037;5606.747696353664;5635.802746903854;5651.9152212716845;5635.408282130368;5635.887282254353;5637.802676906309;5650.0677388231;5651.32184137903;4928.482509336522;4961.603071754269;5093.414257360405;5117.309163262968;5174.068667639824;5005.299258103868;5065.189569668853;5084.923726144092;5092.770825312869;5098.5921126309995;4995.625328100389;5100.846974590768;5102.795888164469;5122.538971492565;5156.355455568054;5203.661761985478;5226.05930932432;5232.843014709565;5258.368995720538;5283.656562323436;4909.631777616657;4955.628327875424;5024;5118.334616499868;5121.436641969381;5388.326459192601;5421.403645598981;5422.43064478232;5441.2654291670515;5464.12573988164;5973.641581505123;5982.7906023289415;6038.667873266969;6039;6043.214382130295;5920.289565252154;6059.2728872535135;6088.817335479943;6098;6100.176476175704;5586.832395028156;5671.51792097668;5673.914891276634;5676.8864622707315;5707.914381284284;6155.076738489262;6182.28903676083;6187.81436556904;6189.288231853305;6195.96902015487;5750.798722044792;5843.620164689281;5947.345791962881;6014.969925150346;6015.3383127855905;6095.512359011268;6109.725062372204;6111.572189946661;6113.174721412642;6132.540059495555;6034.1853849730605;6065.878682426327;6071.362506936708;6077.726502307407;6080.9391906081255;5748.051571490657;5920.2303700519515;5957.6127551709;6059.666718330534;6078.726457309432;4622.191116554657;4627.606653434428;4631.675782695179;4634.119517291704;4658.138244424792;4160.105577300895;4162.91674166515;4173.207090652766;4177.227212965611;4197.559256278047;5461.15352120422;5570.498655121059;5598.356189038232;5699.173619825185;5732.598718089777;6019.909701354483;6020.036794112921;6021.307549631761;6021.909671354933;6113.052476866093;5634.7182640867795;5643.971780141155;5649.06790379591;5651.321841379061;5664.716764161775;5090.49095090488;5198.6880787152895;5213.973930130325;5328.254044433782;5343.625946183807;6247.281562620356;6280.371962803683;6280.9685951569945;6282.4974002079725;6290.276618188876;5829.883402331845;6063.060225665029;6107.4197951194565;6124.816255512342;6130.111133885651;6128.330939843619;6183.134361189347;6220.782272620618;6225.62646241227;6240.594361366497;5943.138244954371;6038.365971572922;6041.124037014521;6047;6052.213212282375;6006.729697163725;6147.692615369303;6150.200473938359;6153.200083989232;6164.630122192682;5757.510611598061;5805.042168042394;5831.970840145772;5832.854178645568;5861.531077513703;5903.114532820111;5970.611910225822;5987.5808693391045;5992;5993.940060599338;5573.3869274380595;5664.150377443417;5809.099589563624;5875.441833025856;5883.0881213411985;5853.824385268449;5899.616524925866;5947.672877991752;5953.732082056405;5977.551683623658;5835.066389377679;5850.2102216200265;5872.677002764889;5876.471117599436;5884.58807883444 08:50:38 INFO - 2016-01-27 08:50:38,955 DEBUG : BROWSER_OUTPUT: |1;ext.html;592.493418127501;624.6127401011372;634.9428202043596;648.4261428635659;671.0638659070594;33477.832610836944;41500.58499415005;42166.36750448738;42252;42374.15251694968;46030;46477.30284045742;46493.302600460935;46523.069538609205;46588.767056164754;7963.562004089802;8133.593320333989;9002.999999999984;9177.449353038839;9179.036201198845;10731.463426828666;10940.343579385222;10977.176711746612;11001.559937602486;11008.229423940327;10687.358758474478;10795.2443328967;10802.5678972841;10802.783944321109;10804.0816530595;10716.839247411295;10762;10837.945810270938;10848.349099054043;10850.511726972305;10571.04860562553;10685.572577096907;10774.946125269324;10776.245662803607;10778.622748203776;43094.353584696255;43336.3499547507;43604.345934811005;43629.78185109086;43643.56356436459;3581.910452238689;3613.602503724588;3827;3964.226975739732;4201.117765269297;32741.508877366858;33057;33423.33153336919;34686;36190.27619447596;4299.441072660534;4340.218760623086;4421.248387774086;4434.35701823237;4436.778161091965;283445;285982.5700871503;286134;286250;286390;58876.70561647164;59788.70105649531;66781;67292;67364.6631766838;74409.25590744024;75467.62266188634;75571;75631;75639.24360756321;16750.916245418695;16974.066426346668;16998.490045298662;16999.49001529956;17010.744838827428;12690.302033388252;12748.49006039748;12766.425510852034;12768.170068945488;12769.553065642658;22545.210917617806;22624.434389140402;22814.771852281596;22878.8856055722;23014;8375.288100511525;8661.397641436355;8690.78273043179;8751.299896008304;8803.647854085764;1049.2130901823632;1080.8432777247256;1102.5865300512307;1103.7406209540752;1214.0530386298524;29616.046072488803;29912.953046643262;30452.84773576118;30485;30948.845255773576;1125.4822781520593;1130.383940752292;1172.8006238939402;1205.2226314027403;1219.7865373559591;15269.694606107816;17247;17826.19782109808;18078.45764627037;18139.818601814077;419572;425585;426508.6023709647;427803;429791;60228.698856506315;60648.696756515936;60656.69671651613;60687.39312606817;60932.69533652392;1453.2080016391092;1472.3815997280954;1473.9263036848115;1477.2023107521818;1499.6850661361018;30936;31462.213444664067;31579.572564120586;31998.200044999063;32345.51481727729;46415.30377044279;47866.52133478621;52390.21414678859;53701.19448208202;53877.46122538725;254421;255766;256689;257112;257270;34508.41186910941;34544.654553454144;34778.30443391169;34951.65048349484;34971.65028349786;44687;45127.09745805;45270;45604;46303;38480.13920257624;39249.60750392459;39384;39694.80152599219;40323;39122.41316380313;39866.800665997645;40090;40199.186056975734;40443.79778101091;38186.427203592524;38887.22225555417;39459.40810887782;39559.80220098881;39570.60429395669;33037.33925321528;34708.82645586756;34990.82504587562;35358.46962295619;35514.467282990256;26232.34419139537;26760.866195668896;26782.59826102571;26811.32971675724;26931.192064238105 08:50:38 INFO - 2016-01-27 08:50:38,955 DEBUG : BROWSER_OUTPUT: |2;jquery.html;374.4103037715599;374.9943750843737;375.60936625909056;384.105035267826;387.21009141351624;15113.546593602183;15182.392704291815;17177.484675459742;18554.35059772908;18584.070796460175;15596.06423614584;17536.12319384029;17720.911395443036;17721.113944302797;18048;4890.706557606537;5414.485623865746;5469.644473109235;5579.7489112990015;5590.91613625796;3982.9601703983026;4092.0383709828166;5442;5616.719164041802;5623.578231632644;5554.638948468357;5568.415316391782;5593.133064375008;5595.076812325961;5604.41153678864;5436.483534064258;5541.556675465973;5567.8886422271735;5597.160425936101;5648.774049038034;5391.083515802323;5407.405185429599;5409.0534156522845;5423.105187644073;5467.152591348347;13350.933245333808;21054.5789084219;21443.57112857734;21473.570528589342;21835.781642183534;2193.100828660258;2214.258223495115;2227.476543012407;2312.491251924574;2328.732195797488;9666.130048295618;9949.850752238723;9988.1510071644;12274.38628068602;13390.397432115578;1923.855710821694;1950.5513731841613;1967.9606407871906;1973.0233534400563;2003.6894281386408;64070.3592964069;66209.66895165494;66251.66874165647;66486.3351366485;67279;10576.788464230825;10769.892301077045;10813;10815.621453249098;10884.564617415215;13970.371333290026;14037.859621403859;14065.296735163201;14164;14168.433262669378;8182.877256841152;8217.83564328722;8224.794380140425;8242.29940455068;8248.587570621445;7888.48724832884;7914.44598878073;7924.960375198202;7951.045874495097;8282.17178282179;4709.717416954925;4764.404449443819;4778.928316075262;4843.660943733976;4864.683795553277;1737.1480249832632;1808.2947650416347;1889.527618095476;1916.6166766646447;1960.715696224068;910.927125829932;979.4221409368507;982.1308142294121;1050.726811029138;1077.2028698763015;16961.660766784596;17041.062741549085;17275.308987640354;18099.366522171662;18425;906.8005038891433;987.1313244345074;996.3125443444001;1003.9899601004042;1008.621766837436;10031.648892288735;10108.1408080314;10137.543810528545;10154.238432117621;10173.796524069625;588503;601362;607950;619360;622256;83511.5824420874;84240;85509;86101;86395.56802215948;1149.143887803575;1161.848959635259;1161.872194058653;1167.550493060178;1175.5767923547517;15896.125713085892;16116.516504504883;16150.757738633694;16251.756223656419;16395.83604163943;35591.82204088963;36458.453123203704;36492.635073648926;36657;37087.81456092702;48613.75693121512;49324;50406.24390634217;50732.277097246944;52227.47772522378;10300.381977081399;10300.433476158883;10642.521086551278;10655.094316983143;10665.200109991627;18188.36340728068;18270.817291826912;18414.72377914359;18517;18632.254709811456;15406;15629.687406252038;15630.687386252439;15698.843011569737;15831.366745330059;15068.773968390264;15141.167235801697;15300.77048844246;15635.765463518284;15643.374265029272;15761.842381576038;15834.129122898352;15928.522144335688;16010.9199454002;16035.759463608289;9686.85469717969;9832.55753491109;9840.753981150528;10104.747381315527;10404.47977601132;10997.12023038139;15270.236488175324;15444.30500627452;15654.21728913527;15981.920090399939 08:50:38 INFO - 2016-01-27 08:50:38,955 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1515.8863085268604;1575.2123938030982;1600.6078510764864;1783.9018853963034;1914.4161030885582;7722.806929826757;8006.718924972006;8009.879851802228;8014.719484818025;8019.839603207933;6944.7569335073285;7141.428685705144;7450.143233528146;7536.547807131576;7828.843423131548;2321.5937210988095;2333.9649905251435;2354.976450235493;2359.374765687094;2360.8701521416315;2028.279960613983;2334.043042352636;2352.6706261123454;2426.0295881647394;2430.8906099225487;2030.583730335285;2308.203669733939;2352.6000579901456;2354.6232602783557;2354.8940297686645;2245.797878190954;2286.4283929017747;2287.2223444028946;2301.9986305956963;2311.711036120485;2240.7759224077627;2252.1892118837204;2278.2595656411568;2280.4982903761147;2300.1374484568287;7763.883541746878;7851.528908265523;7856.567888766115;7864.21357864209;7865.134835168127;4685.5314468553215;4745.027269409763;4748.572628463455;4765.976170119127;4771.952280477186;3070.861811218478;3100.906972790797;3113.532970054487;3124.1564777509943;3220.0983724557163;1078.4230436716318;1116.3748300951493;1131.389049913046;2010.3064442767222;2086.3428020173596;10615;10652.520636571373;10733.195010374175;10745.301555398873;10755.247132700713;4243.236217480821;4304;4307.396964424983;4310.37499562568;4320.092780516064;8913.955430222808;8953.552322383855;8954.731358059269;8959;8965.686200982935;4791.784369703371;4849.030193961222;4859.101066302675;4860.8298709545;4868.829590964299;4393.494748103945;4414.536473670282;4418.558144185556;4454.10917816438;4489.034857505652;3526.1713497328105;3546.1666508370513;3568.7680300780885;3568.9643103568633;3611.5485564304463;1013.8783345998528;1031.8142734307746;1051.169576034924;1056.9312994655477;1071.0842229893485;1141.3608379307448;1151.746615744535;1164.598213616301;1173.7769823733463;1187.3172925567833;7388.335049845432;7479.065116860393;7488.138864030598;7538.962305188439;7603.315701586884;1203;1222.3277197541317;1225.08730995409;1228.3673907937418;1239.6528971887885;6009.36901625323;6029.788957386558;6040.697965101727;6042.39576042401;6062.333143354227;8997.685081022133;9105.772355691028;9234.907650923406;9236.815263694689;9247.583858726373;9388;9433.90566094344;9454.00732923047;9505.714828555154;9550.283728720235;7216.386607138452;7402.778541540585;7461.403087752967;7463.514871533333;7472.887906681404;7411.703531858665;7538.434617403826;7553.0936287643635;7556.811079722831;7580.05249343832;8237.258646721824;8386.832263354821;8448.070712221774;8574.957125214334;8576.356773241907;8490.702825401082;8589.44168629037;8604.870926936226;8680;8737.344699147463;7138.607376594337;7185.712571497082;7217.963910180415;7218.747343842941;7226.927730722626;7166.068411106523;7721.459497835098;7774;7791.181925897699;7796.61016949139;6337;6947.23580406165;6972.755953541602;7063.046488723957;7094.326039026284;6170.660613666291;6644.800655980328;7236.927630723625;7306.4520160989205;7360.07999000125;7364.263573642593;7394.4454165936695;7407.518511296748;7445.181030086578;7445.181030086578;6835.350641689031;6892.965535172292;6894.793156205322;6895.172579290517;6912.827179320558;6804.829879253059;6827.658617069226;6891.3797758202;6893.517453778188;6907.102076730194 08:50:38 INFO - 2016-01-27 08:50:38,959 DEBUG : BROWSER_OUTPUT: |4;prototype.html;351.3955995687418;353.2934131736527;356.8340721564473;364.324178648607;365.19656755138703;6095.542834287429;6158.56890017699;6169.167162433076;6176.876462470748;6181.041938499534;5829.329627092886;5874.647521148723;5985.760569577223;6093.542984276186;6095.786647467339;4702.177119004161;4707.270373092159;4711.458182309044;4724.551167639077;4728.196206644861;4511.2406161597;4681.508441613632;4705.623550115983;4709;4722.64580156488;4572.359869618256;4594.655400844933;4601.976990115045;4623.884402889921;4647.86056418308;4665;4675.812967481296;4703.576678098971;4704.9059018819435;4712.057588482283;4149.294619914592;4163.084121493297;4168.270552653304;4170.666346692287;4170.77060761658;5662.688552129631;5784.623999440065;5798;5799.18811366409;5802.158686990363;5419;5420.810271640513;5421.539169170625;5427.62006659534;5428.891422171534;6537.771178008747;6544.443722283611;6546.770863019819;6547.050677651761;6549.246836613803;4502.729836209838;4503.797329120198;4510.774461276956;4514.774261286955;4530.252508336153;6599.571027883172;6658.234303055162;6743.291954344772;6743.4942379321255;6744.190697116328;4654.743989080565;4661.184292748755;4663.580277775017;4666.743329116931;4673.532646735299;4716;4723.5984941279685;4729.101470720552;4731.030138821533;4732.077244937204;5429.4027656957705;5439.048166570834;5443.156310771837;5444.210589464506;5447.945520544744;6403.199600049994;6570.375814297634;6571.21145462538;6576.408123268833;6579.671016449159;1631.7062928672715;1635.5175223309152;1637.1241385858746;1637.6315329051106;1641.3680732917674;1090.9509072091776;1091.9727006824894;1093.7265683579105;1109.2013750099916;1110.9166812489095;6192.535559833031;6272.341404152589;6275.843103922439;6286.245650521967;6288.245410550763;6625.503087268474;6681.098051763047;6755;6768.120144381297;6771.221309549464;6155.507559395238;6231.376862313732;6272.435480806749;6317.084022816666;6326.525510586633;3627.9637203628154;3659.579148397915;3669.3945498992366;3672.3940549809518;3673.834677439522;6834.897476537856;6974.755883544051;6986.44108471321;6995.440364770806;7001.124859392576;6947.235804061549;6953.965230173918;6955.930440695528;6958.095447591781;6965.825854353681;6978.197507286625;6986.54587451814;6989.26612705679;6989.790306290819;6991.056207412036;6626.83432914181;6781.93218067813;6803.217629972616;6814.420774234246;6819.283975182733;6704.463642908653;6711.4966377520905;6713.362230588086;6714.630695311805;6715.93284067153;6975;6985;6985.755498557526;6992.021117043516;6994.61529615876;4599.103174881;4675.836345727883;4682;4683.297505374221;4701.294805779024;6800.897986530107;6816.0457535946;6822.897656535057;6826.283240259701;6832.350926661959;6627.403533681992;6639.070530125689;6641.236257830411;6644.833879152867;6645.0696902434665;6535.117759102461;6568.343165683394;6615.834604134935;6627.304133065959;6648.268690444144;6498.545101842826;6515.478761699147;6515.576487528296;6515.967420162869;6516.674166291761;6609.570377925419;6644.169478815148;6650.501212409185;6651.4013738761805;6659.2008958925235;6274.560780745304;6473.870522589427;6474.028895665688;6496.382843629847;6535.57518761279 08:50:38 INFO - 2016-01-27 08:50:38,959 DEBUG : BROWSER_OUTPUT: |5;yui.html;804.0994086622983;828.7596596986874;919.8528235482322;922.5064590444113;949.8860136783587;13338.199708017513;13605.795913061313;13630.931845340785;13636.318184090806;13690.794638080437;13590.728185436285;13752.656183595414;13806.723865522683;13818.930905345484;13844.446222151102;894.516960841145;902.1204325782343;905.0858632780905;905.108468158863;905.4612505559214;910.8360495110877;920.0293690156882;920.1350730313517;920.3603495570582;920.9907900920972;945.3666043750669;951.9286053546011;952.5570609666504;953.1516949914547;953.7043516509904;940.9247260219166;946.6497395963469;946.8911075226368;948.6442584030989;948.7533241357262;689.9482538809559;690.3683129936103;690.5338896245014;690.7375197424997;692.4737199728243;13122.34388280582;13190;13209.33953302331;13217.273049982246;13249.73500529984;11273.774524509465;11591.536338546448;11719.882801171965;11789.823152652718;11939.104567157498;9797.363171393836;9882.950585247028;10019.89980100197;10066.29535932485;10239.48802559869;3573.928521429557;3610.151614370621;3617.981910090459;3627.2382799612114;3630.2739452109417;45945.770271148765;46258.30612540815;46467.76766116148;48234.99999999965;48286.27570586444;10062.19502439803;10090.747731306776;10121.1903047756;10431.530581123716;10614.522346494427;17964.640707185783;18000.639987200182;18037.27850885976;18274.26902923895;18279.817201827813;8013.278804907586;8060.758177254575;8212.425130240827;8240.299574536111;8512.021117571434;4237.385579091077;4287.549807270254;4311;4336.132773445323;4422.690411671217;3205.406999705062;3217.17961919709;3219.7263232625487;3230.789998650127;3237.3039796443877;538.9461053894579;558.7653185662032;562.3954249182145;563.0147242325929;567.3532173322416;650.7104338569386;727.3417557110823;733.3912852332658;746.6938555192345;747.7233423633181;9038.954805226063;9040.276777857756;9062.682806101886;9228.584713687766;9449.858252126223;748.9592255442919;755.3466251692356;762.3367670127025;769.1539306762517;781.4803155901376;4192.014876504019;4449.866504004885;4519.231730605805;4579.107074120515;4651.604613607881;57562.7121864388;58848.41151588515;58868.705656471444;59033.40966590279;59088.40911590829;48513.514864851604;48850;51930.480695192564;52482;60374.69812650909;48294.758526207144;48480.7575962125;49084.75457622689;49100.263496047584;49391.50608493941;9016.729498115066;9061.184493395625;9177.954110229406;9440.763980900258;9592.760180995252;35888.64111358853;36255.45616815802;37164.81417592895;37395.43906841454;37533.06167345838;44546;46397;46461.76769116133;47995.52004479911;48092.27861582149;11465.656030319104;11880.168388213087;11965.880341196476;12263.448144833683;12329.876701232874;13511.594652160451;13584.79622805639;13822.170669759847;13868.4452621894;14151.787723184367;11473.13951453661;11482.770344592895;11716.531338746354;11788.646340609796;12459.688507787016;11776;11949.581764638197;12335.259884406963;12544.372781360713;12670.619881403572;12147.514099436277;12160.513579457076;12187.451564679788;12235.388230588613;12600.180988235736;10200.540975655966;10411.375317480975;10637.521311540844;10768.46157692128;10816.134709223086;10189.133923616575;10277.383356998305;10603.41681207541;10626.415547144981;10727.785444291227 08:50:38 INFO - 2016-01-27 08:50:38,959 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:50:38 INFO - 2016-01-27 08:50:38,959 DEBUG : BROWSER_OUTPUT: __start_cc_report 08:50:38 INFO - 2016-01-27 08:50:38,959 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,686 08:50:38 INFO - 2016-01-27 08:50:38,959 DEBUG : BROWSER_OUTPUT: __end_cc_report 08:50:38 INFO - 2016-01-27 08:50:38,959 DEBUG : BROWSER_OUTPUT: __startTimestamp1453913438950__endTimestamp 08:50:38 INFO - 2016-01-27 08:50:38,959 DEBUG : BROWSER_OUTPUT: 08:50:38 INFO - 2016-01-27 08:50:38,959 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:50:38 INFO - 2016-01-27 08:50:38,960 DEBUG : BROWSER_OUTPUT: Number of tests: 6 08:50:38 INFO - 2016-01-27 08:50:38,960 DEBUG : BROWSER_OUTPUT: 08:50:38 INFO - 2016-01-27 08:50:38,960 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5602.81 Median:5829.88 stddev:626.01 (10.7%) stddev-sans-first:602.19 08:50:38 INFO - 2016-01-27 08:50:38,960 DEBUG : BROWSER_OUTPUT: Values: 3338.3 3343.6 3421.7 3442.8 3459.2 5584.1 5604.2 5606.7 5635.8 5651.9 5635.4 5635.9 5637.8 5650.1 5651.3 4928.5 4961.6 5093.4 5117.3 5174.1 5005.3 5065.2 5084.9 5092.8 5098.6 4995.6 5100.8 5102.8 5122.5 5156.4 5203.7 5226.1 5232.8 5258.4 5283.7 4909.6 4955.6 5024.0 5118.3 5121.4 5388.3 5421.4 5422.4 5441.3 5464.1 5973.6 5982.8 6038.7 6039.0 6043.2 5920.3 6059.3 6088.8 6098.0 6100.2 5586.8 5671.5 5673.9 5676.9 5707.9 6155.1 6182.3 6187.8 6189.3 6196.0 5750.8 5843.6 5947.3 6015.0 6015.3 6095.5 6109.7 6111.6 6113.2 6132.5 6034.2 6065.9 6071.4 6077.7 6080.9 5748.1 5920.2 5957.6 6059.7 6078.7 4622.2 4627.6 4631.7 4634.1 4658.1 4160.1 4162.9 4173.2 4177.2 4197.6 5461.2 5570.5 5598.4 5699.2 5732.6 6019.9 6020.0 6021.3 6021.9 6113.1 5634.7 5644.0 5649.1 5651.3 5664.7 5090.5 5198.7 5214.0 5328.3 5343.6 6247.3 6280.4 6281.0 6282.5 6290.3 5829.9 6063.1 6107.4 6124.8 6130.1 6128.3 6183.1 6220.8 6225.6 6240.6 5943.1 6038.4 6041.1 6047.0 6052.2 6006.7 6147.7 6150.2 6153.2 6164.6 5757.5 5805.0 5832.0 5832.9 5861.5 5903.1 5970.6 5987.6 5992.0 5993.9 5573.4 5664.2 5809.1 5875.4 5883.1 5853.8 5899.6 5947.7 5953.7 5977.6 5835.1 5850.2 5872.7 5876.5 5884.6 08:50:38 INFO - 2016-01-27 08:50:38,960 DEBUG : BROWSER_OUTPUT: 08:50:38 INFO - 2016-01-27 08:50:38,960 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:51329.13 Median:34961.65 stddev:86907.37 (248.6%) stddev-sans-first:87067.68 08:50:38 INFO - 2016-01-27 08:50:38,960 DEBUG : BROWSER_OUTPUT: Values: 592.5 624.6 634.9 648.4 671.1 33477.8 41500.6 42166.4 42252.0 42374.2 46030.0 46477.3 46493.3 46523.1 46588.8 7963.6 8133.6 9003.0 9177.4 9179.0 10731.5 10940.3 10977.2 11001.6 11008.2 10687.4 10795.2 10802.6 10802.8 10804.1 10716.8 10762.0 10837.9 10848.3 10850.5 10571.0 10685.6 10774.9 10776.2 10778.6 43094.4 43336.3 43604.3 43629.8 43643.6 3581.9 3613.6 3827.0 3964.2 4201.1 32741.5 33057.0 33423.3 34686.0 36190.3 4299.4 4340.2 4421.2 4434.4 4436.8 283445.0 285982.6 286134.0 286250.0 286390.0 58876.7 59788.7 66781.0 67292.0 67364.7 74409.3 75467.6 75571.0 75631.0 75639.2 16750.9 16974.1 16998.5 16999.5 17010.7 12690.3 12748.5 12766.4 12768.2 12769.6 22545.2 22624.4 22814.8 22878.9 23014.0 8375.3 8661.4 8690.8 8751.3 8803.6 1049.2 1080.8 1102.6 1103.7 1214.1 29616.0 29913.0 30452.8 30485.0 30948.8 1125.5 1130.4 1172.8 1205.2 1219.8 15269.7 17247.0 17826.2 18078.5 18139.8 419572.0 425585.0 426508.6 427803.0 429791.0 60228.7 60648.7 60656.7 60687.4 60932.7 1453.2 1472.4 1473.9 1477.2 1499.7 30936.0 31462.2 31579.6 31998.2 32345.5 46415.3 47866.5 52390.2 53701.2 53877.5 254421.0 255766.0 256689.0 257112.0 257270.0 34508.4 34544.7 34778.3 34951.7 34971.7 44687.0 45127.1 45270.0 45604.0 46303.0 38480.1 39249.6 39384.0 39694.8 40323.0 39122.4 39866.8 40090.0 40199.2 40443.8 38186.4 38887.2 39459.4 39559.8 39570.6 33037.3 34708.8 34990.8 35358.5 35514.5 26232.3 26760.9 26782.6 26811.3 26931.2 08:50:38 INFO - 2016-01-27 08:50:38,960 DEBUG : BROWSER_OUTPUT: 08:50:38 INFO - 2016-01-27 08:50:38,960 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:31600.86 Median:21458.57 stddev:99316.49 (462.8%) stddev-sans-first:99567.42 08:50:38 INFO - 2016-01-27 08:50:38,962 DEBUG : BROWSER_OUTPUT: Values: 374.4 375.0 375.6 384.1 387.2 15113.5 15182.4 17177.5 18554.4 18584.1 15596.1 17536.1 17720.9 17721.1 18048.0 4890.7 5414.5 5469.6 5579.7 5590.9 3983.0 4092.0 5442.0 5616.7 5623.6 5554.6 5568.4 5593.1 5595.1 5604.4 5436.5 5541.6 5567.9 5597.2 5648.8 5391.1 5407.4 5409.1 5423.1 5467.2 13350.9 21054.6 21443.6 21473.6 21835.8 2193.1 2214.3 2227.5 2312.5 2328.7 9666.1 9949.9 9988.2 12274.4 13390.4 1923.9 1950.6 1968.0 1973.0 2003.7 64070.4 66209.7 66251.7 66486.3 67279.0 10576.8 10769.9 10813.0 10815.6 10884.6 13970.4 14037.9 14065.3 14164.0 14168.4 8182.9 8217.8 8224.8 8242.3 8248.6 7888.5 7914.4 7925.0 7951.0 8282.2 4709.7 4764.4 4778.9 4843.7 4864.7 1737.1 1808.3 1889.5 1916.6 1960.7 910.9 979.4 982.1 1050.7 1077.2 16961.7 17041.1 17275.3 18099.4 18425.0 906.8 987.1 996.3 1004.0 1008.6 10031.6 10108.1 10137.5 10154.2 10173.8 588503.0 601362.0 607950.0 619360.0 622256.0 83511.6 84240.0 85509.0 86101.0 86395.6 1149.1 1161.8 1161.9 1167.6 1175.6 15896.1 16116.5 16150.8 16251.8 16395.8 35591.8 36458.5 36492.6 36657.0 37087.8 48613.8 49324.0 50406.2 50732.3 52227.5 10300.4 10300.4 10642.5 10655.1 10665.2 18188.4 18270.8 18414.7 18517.0 18632.3 15406.0 15629.7 15630.7 15698.8 15831.4 15068.8 15141.2 15300.8 15635.8 15643.4 15761.8 15834.1 15928.5 16010.9 16035.8 9686.9 9832.6 9840.8 10104.7 10404.5 10997.1 15270.2 15444.3 15654.2 15981.9 08:50:38 INFO - 2016-01-27 08:50:38,962 DEBUG : BROWSER_OUTPUT: 08:50:38 INFO - 2016-01-27 08:50:38,962 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5553.58 Median:6253.83 stddev:2821.84 (45.1%) stddev-sans-first:2813.43 08:50:38 INFO - 2016-01-27 08:50:38,963 DEBUG : BROWSER_OUTPUT: Values: 1515.9 1575.2 1600.6 1783.9 1914.4 7722.8 8006.7 8009.9 8014.7 8019.8 6944.8 7141.4 7450.1 7536.5 7828.8 2321.6 2334.0 2355.0 2359.4 2360.9 2028.3 2334.0 2352.7 2426.0 2430.9 2030.6 2308.2 2352.6 2354.6 2354.9 2245.8 2286.4 2287.2 2302.0 2311.7 2240.8 2252.2 2278.3 2280.5 2300.1 7763.9 7851.5 7856.6 7864.2 7865.1 4685.5 4745.0 4748.6 4766.0 4772.0 3070.9 3100.9 3113.5 3124.2 3220.1 1078.4 1116.4 1131.4 2010.3 2086.3 10615.0 10652.5 10733.2 10745.3 10755.2 4243.2 4304.0 4307.4 4310.4 4320.1 8914.0 8953.6 8954.7 8959.0 8965.7 4791.8 4849.0 4859.1 4860.8 4868.8 4393.5 4414.5 4418.6 4454.1 4489.0 3526.2 3546.2 3568.8 3569.0 3611.5 1013.9 1031.8 1051.2 1056.9 1071.1 1141.4 1151.7 1164.6 1173.8 1187.3 7388.3 7479.1 7488.1 7539.0 7603.3 1203.0 1222.3 1225.1 1228.4 1239.7 6009.4 6029.8 6040.7 6042.4 6062.3 8997.7 9105.8 9234.9 9236.8 9247.6 9388.0 9433.9 9454.0 9505.7 9550.3 7216.4 7402.8 7461.4 7463.5 7472.9 7411.7 7538.4 7553.1 7556.8 7580.1 8237.3 8386.8 8448.1 8575.0 8576.4 8490.7 8589.4 8604.9 8680.0 8737.3 7138.6 7185.7 7218.0 7218.7 7226.9 7166.1 7721.5 7774.0 7791.2 7796.6 6337.0 6947.2 6972.8 7063.0 7094.3 6170.7 6644.8 7236.9 7306.5 7360.1 7364.3 7394.4 7407.5 7445.2 7445.2 6835.4 6893.0 6894.8 6895.2 6912.8 6804.8 6827.7 6891.4 6893.5 6907.1 08:50:38 INFO - 2016-01-27 08:50:38,963 DEBUG : BROWSER_OUTPUT: 08:50:38 INFO - 2016-01-27 08:50:38,963 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5472.16 Median:6186.79 stddev:1653.53 (26.7%) stddev-sans-first:1612.88 08:50:38 INFO - 2016-01-27 08:50:38,963 DEBUG : BROWSER_OUTPUT: Values: 351.4 353.3 356.8 364.3 365.2 6095.5 6158.6 6169.2 6176.9 6181.0 5829.3 5874.6 5985.8 6093.5 6095.8 4702.2 4707.3 4711.5 4724.6 4728.2 4511.2 4681.5 4705.6 4709.0 4722.6 4572.4 4594.7 4602.0 4623.9 4647.9 4665.0 4675.8 4703.6 4704.9 4712.1 4149.3 4163.1 4168.3 4170.7 4170.8 5662.7 5784.6 5798.0 5799.2 5802.2 5419.0 5420.8 5421.5 5427.6 5428.9 6537.8 6544.4 6546.8 6547.1 6549.2 4502.7 4503.8 4510.8 4514.8 4530.3 6599.6 6658.2 6743.3 6743.5 6744.2 4654.7 4661.2 4663.6 4666.7 4673.5 4716.0 4723.6 4729.1 4731.0 4732.1 5429.4 5439.0 5443.2 5444.2 5447.9 6403.2 6570.4 6571.2 6576.4 6579.7 1631.7 1635.5 1637.1 1637.6 1641.4 1091.0 1092.0 1093.7 1109.2 1110.9 6192.5 6272.3 6275.8 6286.2 6288.2 6625.5 6681.1 6755.0 6768.1 6771.2 6155.5 6231.4 6272.4 6317.1 6326.5 3628.0 3659.6 3669.4 3672.4 3673.8 6834.9 6974.8 6986.4 6995.4 7001.1 6947.2 6954.0 6955.9 6958.1 6965.8 6978.2 6986.5 6989.3 6989.8 6991.1 6626.8 6781.9 6803.2 6814.4 6819.3 6704.5 6711.5 6713.4 6714.6 6715.9 6975.0 6985.0 6985.8 6992.0 6994.6 4599.1 4675.8 4682.0 4683.3 4701.3 6800.9 6816.0 6822.9 6826.3 6832.4 6627.4 6639.1 6641.2 6644.8 6645.1 6535.1 6568.3 6615.8 6627.3 6648.3 6498.5 6515.5 6515.6 6516.0 6516.7 6609.6 6644.2 6650.5 6651.4 6659.2 6274.6 6473.9 6474.0 6496.4 6535.6 08:50:38 INFO - 2016-01-27 08:50:38,963 DEBUG : BROWSER_OUTPUT: 08:50:38 INFO - 2016-01-27 08:50:38,963 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14274.16 Median:24532.62 stddev:16321.61 (66.5%) stddev-sans-first:16336.05 08:50:38 INFO - 2016-01-27 08:50:38,963 DEBUG : BROWSER_OUTPUT: Values: 804.1 828.8 919.9 922.5 949.9 13338.2 13605.8 13630.9 13636.3 13690.8 13590.7 13752.7 13806.7 13818.9 13844.4 894.5 902.1 905.1 905.1 905.5 910.8 920.0 920.1 920.4 921.0 945.4 951.9 952.6 953.2 953.7 940.9 946.6 946.9 948.6 948.8 689.9 690.4 690.5 690.7 692.5 13122.3 13190.0 13209.3 13217.3 13249.7 11273.8 11591.5 11719.9 11789.8 11939.1 9797.4 9883.0 10019.9 10066.3 10239.5 3573.9 3610.2 3618.0 3627.2 3630.3 45945.8 46258.3 46467.8 48235.0 48286.3 10062.2 10090.7 10121.2 10431.5 10614.5 17964.6 18000.6 18037.3 18274.3 18279.8 8013.3 8060.8 8212.4 8240.3 8512.0 4237.4 4287.5 4311.0 4336.1 4422.7 3205.4 3217.2 3219.7 3230.8 3237.3 538.9 558.8 562.4 563.0 567.4 650.7 727.3 733.4 746.7 747.7 9039.0 9040.3 9062.7 9228.6 9449.9 749.0 755.3 762.3 769.2 781.5 4192.0 4449.9 4519.2 4579.1 4651.6 57562.7 58848.4 58868.7 59033.4 59088.4 48513.5 48850.0 51930.5 52482.0 60374.7 48294.8 48480.8 49084.8 49100.3 49391.5 9016.7 9061.2 9178.0 9440.8 9592.8 35888.6 36255.5 37164.8 37395.4 37533.1 44546.0 46397.0 46461.8 47995.5 48092.3 11465.7 11880.2 11965.9 12263.4 12329.9 13511.6 13584.8 13822.2 13868.4 14151.8 11473.1 11482.8 11716.5 11788.6 12459.7 11776.0 11949.6 12335.3 12544.4 12670.6 12147.5 12160.5 12187.5 12235.4 12600.2 10200.5 10411.4 10637.5 10768.5 10816.1 10189.1 10277.4 10603.4 10626.4 10727.8 08:50:38 INFO - 2016-01-27 08:50:38,965 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:50:38 INFO - 2016-01-27 08:50:38,965 DEBUG : BROWSER_OUTPUT: 08:50:39 INFO - 2016-01-27 08:50:39,529 INFO : Browser exited with error code: 0 08:50:39 INFO - 2016-01-27 08:50:39,550 INFO : Completed test dromaeo_css (00:18:29) 08:50:39 INFO - 2016-01-27 08:50:39,550 INFO : Starting test kraken 08:50:39 INFO - 2016-01-27 08:50:39,550 DEBUG : operating with platform_type : linux_ 08:50:39 INFO - 2016-01-27 08:50:39,551 INFO : Initialising browser for kraken test... 08:50:39 INFO - 2016-01-27 08:50:39,557 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpsaRqzi/profile http://localhost:48655/getInfo.html 08:50:43 INFO - 2016-01-27 08:50:43,052 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:50:43 INFO - 2016-01-27 08:50:43,052 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:50:43 INFO - 2016-01-27 08:50:43,052 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 08:50:43 INFO - 2016-01-27 08:50:43,052 DEBUG : BROWSER_OUTPUT: __metrics 08:50:43 INFO - 2016-01-27 08:50:43,214 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] 08:50:44 INFO - 2016-01-27 08:50:44,026 INFO : Browser initialized. 08:50:44 INFO - 2016-01-27 08:50:44,027 INFO : Running cycle 1/1 for kraken test... 08:50:44 INFO - 2016-01-27 08:50:44,027 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpsaRqzi/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:50:55 INFO - 2016-01-27 08:50:55,827 DEBUG : BROWSER_OUTPUT: RSS: Main: 134275072 08:50:55 INFO - 2016-01-27 08:50:55,827 DEBUG : BROWSER_OUTPUT: 08:50:58 INFO - 2016-01-27 08:50:58,266 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48655/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48655/tests/kraken/driver.html?testName=audio-beat-detection) 08:50:58 INFO - 2016-01-27 08:50:58,832 DEBUG : BROWSER_OUTPUT: RSS: Main: 165691392 08:50:58 INFO - 2016-01-27 08:50:58,832 DEBUG : BROWSER_OUTPUT: 08:51:01 INFO - 2016-01-27 08:51:01,388 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48655/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48655/tests/kraken/driver.html?testName=audio-dft) 08:51:01 INFO - 2016-01-27 08:51:01,969 DEBUG : BROWSER_OUTPUT: RSS: Main: 163966976 08:51:01 INFO - 2016-01-27 08:51:01,969 DEBUG : BROWSER_OUTPUT: 08:51:04 INFO - 2016-01-27 08:51:04,739 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48655/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48655/tests/kraken/driver.html?testName=audio-fft) 08:51:05 INFO - 2016-01-27 08:51:05,300 DEBUG : BROWSER_OUTPUT: RSS: Main: 161525760 08:51:05 INFO - 2016-01-27 08:51:05,301 DEBUG : BROWSER_OUTPUT: 08:51:07 INFO - 2016-01-27 08:51:07,252 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48655/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48655/tests/kraken/driver.html?testName=audio-oscillator) 08:51:07 INFO - 2016-01-27 08:51:07,818 DEBUG : BROWSER_OUTPUT: RSS: Main: 160182272 08:51:07 INFO - 2016-01-27 08:51:07,818 DEBUG : BROWSER_OUTPUT: 08:51:09 INFO - 2016-01-27 08:51:09,977 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48655/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48655/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:51:10 INFO - 2016-01-27 08:51:10,538 DEBUG : BROWSER_OUTPUT: RSS: Main: 160886784 08:51:10 INFO - 2016-01-27 08:51:10,539 DEBUG : BROWSER_OUTPUT: 08:51:13 INFO - 2016-01-27 08:51:13,444 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48655/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48655/tests/kraken/driver.html?testName=imaging-darkroom) 08:51:14 INFO - 2016-01-27 08:51:14,018 DEBUG : BROWSER_OUTPUT: RSS: Main: 159657984 08:51:14 INFO - 2016-01-27 08:51:14,018 DEBUG : BROWSER_OUTPUT: 08:51:17 INFO - 2016-01-27 08:51:17,332 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48655/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48655/tests/kraken/driver.html?testName=imaging-desaturate) 08:51:17 INFO - 2016-01-27 08:51:17,897 DEBUG : BROWSER_OUTPUT: RSS: Main: 161292288 08:51:17 INFO - 2016-01-27 08:51:17,898 DEBUG : BROWSER_OUTPUT: 08:51:20 INFO - 2016-01-27 08:51:20,615 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48655/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48655/tests/kraken/driver.html?testName=json-parse-financial) 08:51:21 INFO - 2016-01-27 08:51:21,181 DEBUG : BROWSER_OUTPUT: RSS: Main: 160112640 08:51:21 INFO - 2016-01-27 08:51:21,181 DEBUG : BROWSER_OUTPUT: 08:51:22 INFO - 2016-01-27 08:51:22,715 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48655/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48655/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:51:23 INFO - 2016-01-27 08:51:23,276 DEBUG : BROWSER_OUTPUT: RSS: Main: 165879808 08:51:23 INFO - 2016-01-27 08:51:23,276 DEBUG : BROWSER_OUTPUT: 08:51:25 INFO - 2016-01-27 08:51:25,052 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48655/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48655/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:51:25 INFO - 2016-01-27 08:51:25,653 DEBUG : BROWSER_OUTPUT: RSS: Main: 163868672 08:51:25 INFO - 2016-01-27 08:51:25,653 DEBUG : BROWSER_OUTPUT: 08:51:27 INFO - 2016-01-27 08:51:27,617 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48655/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48655/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:51:28 INFO - 2016-01-27 08:51:28,191 DEBUG : BROWSER_OUTPUT: RSS: Main: 171343872 08:51:28 INFO - 2016-01-27 08:51:28,191 DEBUG : BROWSER_OUTPUT: 08:51:30 INFO - 2016-01-27 08:51:30,585 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48655/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48655/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:51:31 INFO - 2016-01-27 08:51:31,166 DEBUG : BROWSER_OUTPUT: RSS: Main: 175566848 08:51:31 INFO - 2016-01-27 08:51:31,166 DEBUG : BROWSER_OUTPUT: 08:51:33 INFO - 2016-01-27 08:51:33,613 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48655/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48655/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:51:34 INFO - 2016-01-27 08:51:34,179 DEBUG : BROWSER_OUTPUT: RSS: Main: 176259072 08:51:34 INFO - 2016-01-27 08:51:34,179 DEBUG : BROWSER_OUTPUT: 08:51:35 INFO - 2016-01-27 08:51:35,849 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48655/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48655/tests/kraken/driver.html?testName=ai-astar) 08:51:36 INFO - 2016-01-27 08:51:36,099 DEBUG : BROWSER_OUTPUT: RSS: Main: 233111552 08:51:36 INFO - 2016-01-27 08:51:36,099 DEBUG : BROWSER_OUTPUT: 08:51:36 INFO - 2016-01-27 08:51:36,099 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:51:36 INFO - 2016-01-27 08:51:36,099 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:51:36 INFO - 2016-01-27 08:51:36,100 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:51:36 INFO - 2016-01-27 08:51:36,100 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:51:36 INFO - 2016-01-27 08:51:36,101 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;110;104;110;110;110;101;109;110;109 08:51:36 INFO - 2016-01-27 08:51:36,101 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;149;121;147;161;122;146;147;122;167;123 08:51:36 INFO - 2016-01-27 08:51:36,101 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;160;159;160;159;159;160;161;160;158 08:51:36 INFO - 2016-01-27 08:51:36,101 DEBUG : BROWSER_OUTPUT: |3;audio-fft;70;72;72;149;71;71;69;71;154;71 08:51:36 INFO - 2016-01-27 08:51:36,101 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;94;136;93;92;93;133;93;92;136 08:51:36 INFO - 2016-01-27 08:51:36,101 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;111;109;110;110;110;108;109;109;109 08:51:36 INFO - 2016-01-27 08:51:36,101 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;146;146;146;146;146;146;145;146;145 08:51:36 INFO - 2016-01-27 08:51:36,102 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;95;95;95;95;95;96;95 08:51:36 INFO - 2016-01-27 08:51:36,102 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;55;55;57;55;56;56;55;56;54;53 08:51:36 INFO - 2016-01-27 08:51:36,102 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;65;65;65;65;65;66;65;65;65;66 08:51:36 INFO - 2016-01-27 08:51:36,102 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;77;79;80;78;77;78;78;78;78;78 08:51:36 INFO - 2016-01-27 08:51:36,102 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;113;112;115;127;121;121;119;121;118;115 08:51:36 INFO - 2016-01-27 08:51:36,102 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;133;134;143;142;142;133;144;142;143;132 08:51:36 INFO - 2016-01-27 08:51:36,102 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;64;65;64;66;65;65;63;64;65 08:51:36 INFO - 2016-01-27 08:51:36,102 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:51:36 INFO - 2016-01-27 08:51:36,102 DEBUG : BROWSER_OUTPUT: __start_cc_report 08:51:36 INFO - 2016-01-27 08:51:36,102 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,890 08:51:36 INFO - 2016-01-27 08:51:36,102 DEBUG : BROWSER_OUTPUT: __end_cc_report 08:51:36 INFO - 2016-01-27 08:51:36,102 DEBUG : BROWSER_OUTPUT: __startTimestamp1453913496099__endTimestamp 08:51:36 INFO - 2016-01-27 08:51:36,102 DEBUG : BROWSER_OUTPUT: 08:51:36 INFO - 2016-01-27 08:51:36,104 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:51:36 INFO - 2016-01-27 08:51:36,104 DEBUG : BROWSER_OUTPUT: Number of tests: 14 08:51:36 INFO - 2016-01-27 08:51:36,104 DEBUG : BROWSER_OUTPUT: 08:51:36 INFO - 2016-01-27 08:51:36,104 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.40 Median:110.00 stddev:3.24 (2.9%) stddev-sans-first:3.30 08:51:36 INFO - 2016-01-27 08:51:36,104 DEBUG : BROWSER_OUTPUT: Values: 111.0 110.0 104.0 110.0 110.0 110.0 101.0 109.0 110.0 109.0 08:51:36 INFO - 2016-01-27 08:51:36,104 DEBUG : BROWSER_OUTPUT: 08:51:36 INFO - 2016-01-27 08:51:36,104 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:140.50 Median:147.00 stddev:17.26 (11.7%) stddev-sans-first:18.03 08:51:36 INFO - 2016-01-27 08:51:36,104 DEBUG : BROWSER_OUTPUT: Values: 149.0 121.0 147.0 161.0 122.0 146.0 147.0 122.0 167.0 123.0 08:51:36 INFO - 2016-01-27 08:51:36,104 DEBUG : BROWSER_OUTPUT: 08:51:36 INFO - 2016-01-27 08:51:36,104 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:159.70 Median:160.00 stddev:0.95 (0.6%) stddev-sans-first:0.88 08:51:36 INFO - 2016-01-27 08:51:36,104 DEBUG : BROWSER_OUTPUT: Values: 161.0 160.0 159.0 160.0 159.0 159.0 160.0 161.0 160.0 158.0 08:51:36 INFO - 2016-01-27 08:51:36,104 DEBUG : BROWSER_OUTPUT: 08:51:36 INFO - 2016-01-27 08:51:36,104 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:87.00 Median:71.00 stddev:34.03 (47.9%) stddev-sans-first:35.53 08:51:36 INFO - 2016-01-27 08:51:36,105 DEBUG : BROWSER_OUTPUT: Values: 70.0 72.0 72.0 149.0 71.0 71.0 69.0 71.0 154.0 71.0 08:51:36 INFO - 2016-01-27 08:51:36,105 DEBUG : BROWSER_OUTPUT: 08:51:36 INFO - 2016-01-27 08:51:36,105 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.50 Median:93.00 stddev:20.38 (21.9%) stddev-sans-first:21.11 08:51:36 INFO - 2016-01-27 08:51:36,105 DEBUG : BROWSER_OUTPUT: Values: 93.0 94.0 136.0 93.0 92.0 93.0 133.0 93.0 92.0 136.0 08:51:36 INFO - 2016-01-27 08:51:36,105 DEBUG : BROWSER_OUTPUT: 08:51:36 INFO - 2016-01-27 08:51:36,105 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.50 stddev:0.84 (0.8%) stddev-sans-first:0.88 08:51:36 INFO - 2016-01-27 08:51:36,105 DEBUG : BROWSER_OUTPUT: Values: 109.0 111.0 109.0 110.0 110.0 110.0 108.0 109.0 109.0 109.0 08:51:36 INFO - 2016-01-27 08:51:36,105 DEBUG : BROWSER_OUTPUT: 08:51:36 INFO - 2016-01-27 08:51:36,105 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 08:51:36 INFO - 2016-01-27 08:51:36,106 DEBUG : BROWSER_OUTPUT: Values: 146.0 146.0 146.0 146.0 146.0 146.0 146.0 145.0 146.0 145.0 08:51:36 INFO - 2016-01-27 08:51:36,107 DEBUG : BROWSER_OUTPUT: 08:51:36 INFO - 2016-01-27 08:51:36,107 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 08:51:36 INFO - 2016-01-27 08:51:36,107 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 08:51:36 INFO - 2016-01-27 08:51:36,107 DEBUG : BROWSER_OUTPUT: 08:51:36 INFO - 2016-01-27 08:51:36,107 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:55.20 Median:55.50 stddev:1.14 (2.0%) stddev-sans-first:1.20 08:51:36 INFO - 2016-01-27 08:51:36,107 DEBUG : BROWSER_OUTPUT: Values: 55.0 55.0 57.0 55.0 56.0 56.0 55.0 56.0 54.0 53.0 08:51:36 INFO - 2016-01-27 08:51:36,107 DEBUG : BROWSER_OUTPUT: 08:51:36 INFO - 2016-01-27 08:51:36,107 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:65.20 Median:65.00 stddev:0.42 (0.6%) stddev-sans-first:0.44 08:51:36 INFO - 2016-01-27 08:51:36,107 DEBUG : BROWSER_OUTPUT: Values: 65.0 65.0 65.0 65.0 65.0 66.0 65.0 65.0 65.0 66.0 08:51:36 INFO - 2016-01-27 08:51:36,107 DEBUG : BROWSER_OUTPUT: 08:51:36 INFO - 2016-01-27 08:51:36,107 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:78.10 Median:78.00 stddev:0.88 (1.1%) stddev-sans-first:0.83 08:51:36 INFO - 2016-01-27 08:51:36,107 DEBUG : BROWSER_OUTPUT: Values: 77.0 79.0 80.0 78.0 77.0 78.0 78.0 78.0 78.0 78.0 08:51:36 INFO - 2016-01-27 08:51:36,107 DEBUG : BROWSER_OUTPUT: 08:51:36 INFO - 2016-01-27 08:51:36,107 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:118.20 Median:120.00 stddev:4.57 (3.8%) stddev-sans-first:4.44 08:51:36 INFO - 2016-01-27 08:51:36,107 DEBUG : BROWSER_OUTPUT: Values: 113.0 112.0 115.0 127.0 121.0 121.0 119.0 121.0 118.0 115.0 08:51:36 INFO - 2016-01-27 08:51:36,107 DEBUG : BROWSER_OUTPUT: 08:51:36 INFO - 2016-01-27 08:51:36,108 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:138.80 Median:142.00 stddev:5.05 (3.6%) stddev-sans-first:4.90 08:51:36 INFO - 2016-01-27 08:51:36,108 DEBUG : BROWSER_OUTPUT: Values: 133.0 134.0 143.0 142.0 142.0 133.0 144.0 142.0 143.0 132.0 08:51:36 INFO - 2016-01-27 08:51:36,108 DEBUG : BROWSER_OUTPUT: 08:51:36 INFO - 2016-01-27 08:51:36,108 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.90 Median:65.00 stddev:1.37 (2.1%) stddev-sans-first:0.88 08:51:36 INFO - 2016-01-27 08:51:36,108 DEBUG : BROWSER_OUTPUT: Values: 68.0 64.0 65.0 64.0 66.0 65.0 65.0 63.0 64.0 65.0 08:51:36 INFO - 2016-01-27 08:51:36,108 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:51:36 INFO - 2016-01-27 08:51:36,108 DEBUG : BROWSER_OUTPUT: 08:51:36 INFO - 2016-01-27 08:51:36,718 INFO : Browser exited with error code: 0 08:51:36 INFO - 2016-01-27 08:51:36,768 INFO : Completed test kraken (00:00:57) 08:51:36 INFO - 2016-01-27 08:51:36,768 INFO : Starting test v8_7 08:51:36 INFO - 2016-01-27 08:51:36,768 DEBUG : operating with platform_type : linux_ 08:51:36 INFO - 2016-01-27 08:51:36,768 INFO : Initialising browser for v8_7 test... 08:51:36 INFO - 2016-01-27 08:51:36,774 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpqPQryT/profile http://localhost:48655/getInfo.html 08:51:40 INFO - 2016-01-27 08:51:40,420 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:51:40 INFO - 2016-01-27 08:51:40,420 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:51:40 INFO - 2016-01-27 08:51:40,420 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 08:51:40 INFO - 2016-01-27 08:51:40,420 DEBUG : BROWSER_OUTPUT: __metrics 08:51:40 INFO - 2016-01-27 08:51:40,529 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] 08:51:41 INFO - 2016-01-27 08:51:41,243 INFO : Browser initialized. 08:51:41 INFO - 2016-01-27 08:51:41,244 INFO : Running cycle 1/1 for v8_7 test... 08:51:41 INFO - 2016-01-27 08:51:41,244 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpqPQryT/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:51:52 INFO - 2016-01-27 08:51:52,980 DEBUG : BROWSER_OUTPUT: RSS: Main: 134885376 08:51:52 INFO - 2016-01-27 08:51:52,980 DEBUG : BROWSER_OUTPUT: 08:52:14 INFO - 2016-01-27 08:52:14,324 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48655/tests/v8_7/run.html (next: http://localhost:48655/tests/v8_7/run.html) 08:52:14 INFO - 2016-01-27 08:52:14,583 DEBUG : BROWSER_OUTPUT: RSS: Main: 421883904 08:52:14 INFO - 2016-01-27 08:52:14,583 DEBUG : BROWSER_OUTPUT: 08:52:14 INFO - 2016-01-27 08:52:14,583 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:52:14 INFO - 2016-01-27 08:52:14,583 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:52:14 INFO - 2016-01-27 08:52:14,583 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:52:14 INFO - 2016-01-27 08:52:14,584 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:52:14 INFO - 2016-01-27 08:52:14,584 DEBUG : BROWSER_OUTPUT: |0;Richards;172.41379310344828 08:52:14 INFO - 2016-01-27 08:52:14,584 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;165.0709805216243 08:52:14 INFO - 2016-01-27 08:52:14,584 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.50490883590464 08:52:14 INFO - 2016-01-27 08:52:14,584 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5186.5284974093265 08:52:14 INFO - 2016-01-27 08:52:14,584 DEBUG : BROWSER_OUTPUT: |4;RayTrace;976.5625 08:52:14 INFO - 2016-01-27 08:52:14,584 DEBUG : BROWSER_OUTPUT: |5;Earley;543.1830526887561 08:52:14 INFO - 2016-01-27 08:52:14,584 DEBUG : BROWSER_OUTPUT: |6;Boyer;10536.842105263158 08:52:14 INFO - 2016-01-27 08:52:14,585 DEBUG : BROWSER_OUTPUT: |7;RegExp;24238.095238095237 08:52:14 INFO - 2016-01-27 08:52:14,585 DEBUG : BROWSER_OUTPUT: |8;Splay;527.9831045406547 08:52:14 INFO - 2016-01-27 08:52:14,585 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 08:52:14 INFO - 2016-01-27 08:52:14,585 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:52:14 INFO - 2016-01-27 08:52:14,585 DEBUG : BROWSER_OUTPUT: __startTimestamp1453913534576__endTimestamp 08:52:14 INFO - 2016-01-27 08:52:14,585 DEBUG : BROWSER_OUTPUT: 08:52:14 INFO - 2016-01-27 08:52:14,586 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:52:14 INFO - 2016-01-27 08:52:14,586 DEBUG : BROWSER_OUTPUT: Number of tests: 10 08:52:14 INFO - 2016-01-27 08:52:14,586 DEBUG : BROWSER_OUTPUT: 08:52:14 INFO - 2016-01-27 08:52:14,586 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:172.41 Median:172.41 stddev:0.00 (0.0%) 08:52:14 INFO - 2016-01-27 08:52:14,586 DEBUG : BROWSER_OUTPUT: Values: 172.4 08:52:14 INFO - 2016-01-27 08:52:14,586 DEBUG : BROWSER_OUTPUT: 08:52:14 INFO - 2016-01-27 08:52:14,586 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:165.07 Median:165.07 stddev:0.00 (0.0%) 08:52:14 INFO - 2016-01-27 08:52:14,586 DEBUG : BROWSER_OUTPUT: Values: 165.1 08:52:14 INFO - 2016-01-27 08:52:14,587 DEBUG : BROWSER_OUTPUT: 08:52:14 INFO - 2016-01-27 08:52:14,587 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.50 Median:280.50 stddev:0.00 (0.0%) 08:52:14 INFO - 2016-01-27 08:52:14,587 DEBUG : BROWSER_OUTPUT: Values: 280.5 08:52:14 INFO - 2016-01-27 08:52:14,587 DEBUG : BROWSER_OUTPUT: 08:52:14 INFO - 2016-01-27 08:52:14,587 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5186.53 Median:5186.53 stddev:0.00 (0.0%) 08:52:14 INFO - 2016-01-27 08:52:14,587 DEBUG : BROWSER_OUTPUT: Values: 5186.5 08:52:14 INFO - 2016-01-27 08:52:14,587 DEBUG : BROWSER_OUTPUT: 08:52:14 INFO - 2016-01-27 08:52:14,588 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:976.56 Median:976.56 stddev:0.00 (0.0%) 08:52:14 INFO - 2016-01-27 08:52:14,588 DEBUG : BROWSER_OUTPUT: Values: 976.6 08:52:14 INFO - 2016-01-27 08:52:14,588 DEBUG : BROWSER_OUTPUT: 08:52:14 INFO - 2016-01-27 08:52:14,588 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:543.18 Median:543.18 stddev:0.00 (0.0%) 08:52:14 INFO - 2016-01-27 08:52:14,588 DEBUG : BROWSER_OUTPUT: Values: 543.2 08:52:14 INFO - 2016-01-27 08:52:14,588 DEBUG : BROWSER_OUTPUT: 08:52:14 INFO - 2016-01-27 08:52:14,588 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10536.84 Median:10536.84 stddev:0.00 (0.0%) 08:52:14 INFO - 2016-01-27 08:52:14,588 DEBUG : BROWSER_OUTPUT: Values: 10536.8 08:52:14 INFO - 2016-01-27 08:52:14,589 DEBUG : BROWSER_OUTPUT: 08:52:14 INFO - 2016-01-27 08:52:14,589 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24238.10 Median:24238.10 stddev:0.00 (0.0%) 08:52:14 INFO - 2016-01-27 08:52:14,589 DEBUG : BROWSER_OUTPUT: Values: 24238.1 08:52:14 INFO - 2016-01-27 08:52:14,589 DEBUG : BROWSER_OUTPUT: 08:52:14 INFO - 2016-01-27 08:52:14,589 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:527.98 Median:527.98 stddev:0.00 (0.0%) 08:52:14 INFO - 2016-01-27 08:52:14,589 DEBUG : BROWSER_OUTPUT: Values: 528.0 08:52:14 INFO - 2016-01-27 08:52:14,589 DEBUG : BROWSER_OUTPUT: 08:52:14 INFO - 2016-01-27 08:52:14,590 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 08:52:14 INFO - 2016-01-27 08:52:14,590 DEBUG : BROWSER_OUTPUT: Values: 4840.6 08:52:14 INFO - 2016-01-27 08:52:14,590 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:52:14 INFO - 2016-01-27 08:52:14,590 DEBUG : BROWSER_OUTPUT: 08:52:15 INFO - 2016-01-27 08:52:15,242 INFO : Browser exited with error code: 0 08:52:15 INFO - 2016-01-27 08:52:15,258 INFO : Completed test v8_7 (00:00:38) 08:52:15 INFO - 2016-01-27 08:52:15,654 INFO : Completed test suite (00:20:05) 08:52:15 INFO - 2016-01-27 08:52:15,654 DEBUG : Working with test: dromaeo_css 08:52:15 INFO - 2016-01-27 08:52:15,654 DEBUG : Generating results file: dromaeo_css 08:52:15 INFO - 2016-01-27 08:52:15,655 DEBUG : Working with test: kraken 08:52:15 INFO - 2016-01-27 08:52:15,655 DEBUG : Generating results file: kraken 08:52:15 INFO - 2016-01-27 08:52:15,656 INFO : javascript benchmark 08:52:15 INFO - 2016-01-27 08:52:15,656 DEBUG : Working with test: v8_7 08:52:15 INFO - 2016-01-27 08:52:15,656 DEBUG : Generating results file: v8_7 08:52:15 INFO - 2016-01-27 08:52:15,656 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:52:15 INFO - 2016-01-27 08:52:15,709 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,53,35]] 08:52:15 INFO - 2016-01-27 08:52:15,710 DEBUG : process_Request line: dromaeo_css 7389.97 graph.html#tests=[[72,53,35]] 08:52:15 INFO - 2016-01-27 08:52:15,710 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:52:15 INFO - 2016-01-27 08:52:15,737 DEBUG : process_Request line: kraken 1471.80 graph.html#tests=[[232,53,35]] 08:52:15 INFO - 2016-01-27 08:52:15,737 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:52:15 INFO - 2016-01-27 08:52:15,779 DEBUG : process_Request line: v8_7 23107.44 graph.html#tests=[[230,53,35]] 08:52:15 INFO - 2016-01-27 08:52:15,780 INFO : javascript benchmark 08:52:15 INFO - 2016-01-27 08:52:15,784 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3338.298957218984, 3343.648916863729, 3421.7091547218483, 3442.827858607069, 3459.2043829919116, 5584.050711379065, 5604.187392828037, 5606.747696353664, 5635.802746903854, 5651.9152212716845, 5635.408282130368, 5635.887282254353, 5637.802676906309, 5650.0677388231, 5651.32184137903, 4928.482509336522, 4961.603071754269, 5093.414257360405, 5117.309163262968, 5174.068667639824, 5005.299258103868, 5065.189569668853, 5084.923726144092, 5092.770825312869, 5098.5921126309995, 4995.625328100389, 5100.846974590768, 5102.795888164469, 5122.538971492565, 5156.355455568054, 5203.661761985478, 5226.05930932432, 5232.843014709565, 5258.368995720538, 5283.656562323436, 4909.631777616657, 4955.628327875424, 5024.0, 5118.334616499868, 5121.436641969381, 5388.326459192601, 5421.403645598981, 5422.43064478232, 5441.2654291670515, 5464.12573988164, 5973.641581505123, 5982.7906023289415, 6038.667873266969, 6039.0, 6043.214382130295, 5920.289565252154, 6059.2728872535135, 6088.817335479943, 6098.0, 6100.176476175704, 5586.832395028156, 5671.51792097668, 5673.914891276634, 5676.8864622707315, 5707.914381284284, 6155.076738489262, 6182.28903676083, 6187.81436556904, 6189.288231853305, 6195.96902015487, 5750.798722044792, 5843.620164689281, 5947.345791962881, 6014.969925150346, 6015.3383127855905, 6095.512359011268, 6109.725062372204, 6111.572189946661, 6113.174721412642, 6132.540059495555, 6034.1853849730605, 6065.878682426327, 6071.362506936708, 6077.726502307407, 6080.9391906081255, 5748.051571490657, 5920.2303700519515, 5957.6127551709, 6059.666718330534, 6078.726457309432, 4622.191116554657, 4627.606653434428, 4631.675782695179, 4634.119517291704, 4658.138244424792, 4160.105577300895, 4162.91674166515, 4173.207090652766, 4177.227212965611, 4197.559256278047, 5461.15352120422, 5570.498655121059, 5598.356189038232, 5699.173619825185, 5732.598718089777, 6019.909701354483, 6020.036794112921, 6021.307549631761, 6021.909671354933, 6113.052476866093, 5634.7182640867795, 5643.971780141155, 5649.06790379591, 5651.321841379061, 5664.716764161775, 5090.49095090488, 5198.6880787152895, 5213.973930130325, 5328.254044433782, 5343.625946183807, 6247.281562620356, 6280.371962803683, 6280.9685951569945, 6282.4974002079725, 6290.276618188876, 5829.883402331845, 6063.060225665029, 6107.4197951194565, 6124.816255512342, 6130.111133885651, 6128.330939843619, 6183.134361189347, 6220.782272620618, 6225.62646241227, 6240.594361366497, 5943.138244954371, 6038.365971572922, 6041.124037014521, 6047.0, 6052.213212282375, 6006.729697163725, 6147.692615369303, 6150.200473938359, 6153.200083989232, 6164.630122192682, 5757.510611598061, 5805.042168042394, 5831.970840145772, 5832.854178645568, 5861.531077513703, 5903.114532820111, 5970.611910225822, 5987.5808693391045, 5992.0, 5993.940060599338, 5573.3869274380595, 5664.150377443417, 5809.099589563624, 5875.441833025856, 5883.0881213411985, 5853.824385268449, 5899.616524925866, 5947.672877991752, 5953.732082056405, 5977.551683623658, 5835.066389377679, 5850.2102216200265, 5872.677002764889, 5876.471117599436, 5884.58807883444], "unit": "ms", "name": "dojo.html", "value": 5562.3508983518095}, {"lowerIsBetter": false, "replicates": [592.493418127501, 624.6127401011372, 634.9428202043596, 648.4261428635659, 671.0638659070594, 33477.832610836944, 41500.58499415005, 42166.36750448738, 42252.0, 42374.15251694968, 46030.0, 46477.30284045742, 46493.302600460935, 46523.069538609205, 46588.767056164754, 7963.562004089802, 8133.593320333989, 9002.999999999984, 9177.449353038839, 9179.036201198845, 10731.463426828666, 10940.343579385222, 10977.176711746612, 11001.559937602486, 11008.229423940327, 10687.358758474478, 10795.2443328967, 10802.5678972841, 10802.783944321109, 10804.0816530595, 10716.839247411295, 10762.0, 10837.945810270938, 10848.349099054043, 10850.511726972305, 10571.04860562553, 10685.572577096907, 10774.946125269324, 10776.245662803607, 10778.622748203776, 43094.353584696255, 43336.3499547507, 43604.345934811005, 43629.78185109086, 43643.56356436459, 3581.910452238689, 3613.602503724588, 3827.0, 3964.226975739732, 4201.117765269297, 32741.508877366858, 33057.0, 33423.33153336919, 34686.0, 36190.27619447596, 4299.441072660534, 4340.218760623086, 4421.248387774086, 4434.35701823237, 4436.778161091965, 283445.0, 285982.5700871503, 286134.0, 286250.0, 286390.0, 58876.70561647164, 59788.70105649531, 66781.0, 67292.0, 67364.6631766838, 74409.25590744024, 75467.62266188634, 75571.0, 75631.0, 75639.24360756321, 16750.916245418695, 16974.066426346668, 16998.490045298662, 16999.49001529956, 17010.744838827428, 12690.302033388252, 12748.49006039748, 12766.425510852034, 12768.170068945488, 12769.553065642658, 22545.210917617806, 22624.434389140402, 22814.771852281596, 22878.8856055722, 23014.0, 8375.288100511525, 8661.397641436355, 8690.78273043179, 8751.299896008304, 8803.647854085764, 1049.2130901823632, 1080.8432777247256, 1102.5865300512307, 1103.7406209540752, 1214.0530386298524, 29616.046072488803, 29912.953046643262, 30452.84773576118, 30485.0, 30948.845255773576, 1125.4822781520593, 1130.383940752292, 1172.8006238939402, 1205.2226314027403, 1219.7865373559591, 15269.694606107816, 17247.0, 17826.19782109808, 18078.45764627037, 18139.818601814077, 419572.0, 425585.0, 426508.6023709647, 427803.0, 429791.0, 60228.698856506315, 60648.696756515936, 60656.69671651613, 60687.39312606817, 60932.69533652392, 1453.2080016391092, 1472.3815997280954, 1473.9263036848115, 1477.2023107521818, 1499.6850661361018, 30936.0, 31462.213444664067, 31579.572564120586, 31998.200044999063, 32345.51481727729, 46415.30377044279, 47866.52133478621, 52390.21414678859, 53701.19448208202, 53877.46122538725, 254421.0, 255766.0, 256689.0, 257112.0, 257270.0, 34508.41186910941, 34544.654553454144, 34778.30443391169, 34951.65048349484, 34971.65028349786, 44687.0, 45127.09745805, 45270.0, 45604.0, 46303.0, 38480.13920257624, 39249.60750392459, 39384.0, 39694.80152599219, 40323.0, 39122.41316380313, 39866.800665997645, 40090.0, 40199.186056975734, 40443.79778101091, 38186.427203592524, 38887.22225555417, 39459.40810887782, 39559.80220098881, 39570.60429395669, 33037.33925321528, 34708.82645586756, 34990.82504587562, 35358.46962295619, 35514.467282990256, 26232.34419139537, 26760.866195668896, 26782.59826102571, 26811.32971675724, 26931.192064238105], "unit": "ms", "name": "ext.html", "value": 20600.843557581746}, {"lowerIsBetter": false, "replicates": [374.4103037715599, 374.9943750843737, 375.60936625909056, 384.105035267826, 387.21009141351624, 15113.546593602183, 15182.392704291815, 17177.484675459742, 18554.35059772908, 18584.070796460175, 15596.06423614584, 17536.12319384029, 17720.911395443036, 17721.113944302797, 18048.0, 4890.706557606537, 5414.485623865746, 5469.644473109235, 5579.7489112990015, 5590.91613625796, 3982.9601703983026, 4092.0383709828166, 5442.0, 5616.719164041802, 5623.578231632644, 5554.638948468357, 5568.415316391782, 5593.133064375008, 5595.076812325961, 5604.41153678864, 5436.483534064258, 5541.556675465973, 5567.8886422271735, 5597.160425936101, 5648.774049038034, 5391.083515802323, 5407.405185429599, 5409.0534156522845, 5423.105187644073, 5467.152591348347, 13350.933245333808, 21054.5789084219, 21443.57112857734, 21473.570528589342, 21835.781642183534, 2193.100828660258, 2214.258223495115, 2227.476543012407, 2312.491251924574, 2328.732195797488, 9666.130048295618, 9949.850752238723, 9988.1510071644, 12274.38628068602, 13390.397432115578, 1923.855710821694, 1950.5513731841613, 1967.9606407871906, 1973.0233534400563, 2003.6894281386408, 64070.3592964069, 66209.66895165494, 66251.66874165647, 66486.3351366485, 67279.0, 10576.788464230825, 10769.892301077045, 10813.0, 10815.621453249098, 10884.564617415215, 13970.371333290026, 14037.859621403859, 14065.296735163201, 14164.0, 14168.433262669378, 8182.877256841152, 8217.83564328722, 8224.794380140425, 8242.29940455068, 8248.587570621445, 7888.48724832884, 7914.44598878073, 7924.960375198202, 7951.045874495097, 8282.17178282179, 4709.717416954925, 4764.404449443819, 4778.928316075262, 4843.660943733976, 4864.683795553277, 1737.1480249832632, 1808.2947650416347, 1889.527618095476, 1916.6166766646447, 1960.715696224068, 910.927125829932, 979.4221409368507, 982.1308142294121, 1050.726811029138, 1077.2028698763015, 16961.660766784596, 17041.062741549085, 17275.308987640354, 18099.366522171662, 18425.0, 906.8005038891433, 987.1313244345074, 996.3125443444001, 1003.9899601004042, 1008.621766837436, 10031.648892288735, 10108.1408080314, 10137.543810528545, 10154.238432117621, 10173.796524069625, 588503.0, 601362.0, 607950.0, 619360.0, 622256.0, 83511.5824420874, 84240.0, 85509.0, 86101.0, 86395.56802215948, 1149.143887803575, 1161.848959635259, 1161.872194058653, 1167.550493060178, 1175.5767923547517, 15896.125713085892, 16116.516504504883, 16150.757738633694, 16251.756223656419, 16395.83604163943, 35591.82204088963, 36458.453123203704, 36492.635073648926, 36657.0, 37087.81456092702, 48613.75693121512, 49324.0, 50406.24390634217, 50732.277097246944, 52227.47772522378, 10300.381977081399, 10300.433476158883, 10642.521086551278, 10655.094316983143, 10665.200109991627, 18188.36340728068, 18270.817291826912, 18414.72377914359, 18517.0, 18632.254709811456, 15406.0, 15629.687406252038, 15630.687386252439, 15698.843011569737, 15831.366745330059, 15068.773968390264, 15141.167235801697, 15300.77048844246, 15635.765463518284, 15643.374265029272, 15761.842381576038, 15834.129122898352, 15928.522144335688, 16010.9199454002, 16035.759463608289, 9686.85469717969, 9832.55753491109, 9840.753981150528, 10104.747381315527, 10404.47977601132, 10997.12023038139, 15270.236488175324, 15444.30500627452, 15654.21728913527, 15981.920090399939], "unit": "ms", "name": "jquery.html", "value": 9370.64577459326}, {"lowerIsBetter": false, "replicates": [1515.8863085268604, 1575.2123938030982, 1600.6078510764864, 1783.9018853963034, 1914.4161030885582, 7722.806929826757, 8006.718924972006, 8009.879851802228, 8014.719484818025, 8019.839603207933, 6944.7569335073285, 7141.428685705144, 7450.143233528146, 7536.547807131576, 7828.843423131548, 2321.5937210988095, 2333.9649905251435, 2354.976450235493, 2359.374765687094, 2360.8701521416315, 2028.279960613983, 2334.043042352636, 2352.6706261123454, 2426.0295881647394, 2430.8906099225487, 2030.583730335285, 2308.203669733939, 2352.6000579901456, 2354.6232602783557, 2354.8940297686645, 2245.797878190954, 2286.4283929017747, 2287.2223444028946, 2301.9986305956963, 2311.711036120485, 2240.7759224077627, 2252.1892118837204, 2278.2595656411568, 2280.4982903761147, 2300.1374484568287, 7763.883541746878, 7851.528908265523, 7856.567888766115, 7864.21357864209, 7865.134835168127, 4685.5314468553215, 4745.027269409763, 4748.572628463455, 4765.976170119127, 4771.952280477186, 3070.861811218478, 3100.906972790797, 3113.532970054487, 3124.1564777509943, 3220.0983724557163, 1078.4230436716318, 1116.3748300951493, 1131.389049913046, 2010.3064442767222, 2086.3428020173596, 10615.0, 10652.520636571373, 10733.195010374175, 10745.301555398873, 10755.247132700713, 4243.236217480821, 4304.0, 4307.396964424983, 4310.37499562568, 4320.092780516064, 8913.955430222808, 8953.552322383855, 8954.731358059269, 8959.0, 8965.686200982935, 4791.784369703371, 4849.030193961222, 4859.101066302675, 4860.8298709545, 4868.829590964299, 4393.494748103945, 4414.536473670282, 4418.558144185556, 4454.10917816438, 4489.034857505652, 3526.1713497328105, 3546.1666508370513, 3568.7680300780885, 3568.9643103568633, 3611.5485564304463, 1013.8783345998528, 1031.8142734307746, 1051.169576034924, 1056.9312994655477, 1071.0842229893485, 1141.3608379307448, 1151.746615744535, 1164.598213616301, 1173.7769823733463, 1187.3172925567833, 7388.335049845432, 7479.065116860393, 7488.138864030598, 7538.962305188439, 7603.315701586884, 1203.0, 1222.3277197541317, 1225.08730995409, 1228.3673907937418, 1239.6528971887885, 6009.36901625323, 6029.788957386558, 6040.697965101727, 6042.39576042401, 6062.333143354227, 8997.685081022133, 9105.772355691028, 9234.907650923406, 9236.815263694689, 9247.583858726373, 9388.0, 9433.90566094344, 9454.00732923047, 9505.714828555154, 9550.283728720235, 7216.386607138452, 7402.778541540585, 7461.403087752967, 7463.514871533333, 7472.887906681404, 7411.703531858665, 7538.434617403826, 7553.0936287643635, 7556.811079722831, 7580.05249343832, 8237.258646721824, 8386.832263354821, 8448.070712221774, 8574.957125214334, 8576.356773241907, 8490.702825401082, 8589.44168629037, 8604.870926936226, 8680.0, 8737.344699147463, 7138.607376594337, 7185.712571497082, 7217.963910180415, 7218.747343842941, 7226.927730722626, 7166.068411106523, 7721.459497835098, 7774.0, 7791.181925897699, 7796.61016949139, 6337.0, 6947.23580406165, 6972.755953541602, 7063.046488723957, 7094.326039026284, 6170.660613666291, 6644.800655980328, 7236.927630723625, 7306.4520160989205, 7360.07999000125, 7364.263573642593, 7394.4454165936695, 7407.518511296748, 7445.181030086578, 7445.181030086578, 6835.350641689031, 6892.965535172292, 6894.793156205322, 6895.172579290517, 6912.827179320558, 6804.829879253059, 6827.658617069226, 6891.3797758202, 6893.517453778188, 6907.102076730194], "unit": "ms", "name": "mootools.html", "value": 4605.4491972121095}, {"lowerIsBetter": false, "replicates": [351.3955995687418, 353.2934131736527, 356.8340721564473, 364.324178648607, 365.19656755138703, 6095.542834287429, 6158.56890017699, 6169.167162433076, 6176.876462470748, 6181.041938499534, 5829.329627092886, 5874.647521148723, 5985.760569577223, 6093.542984276186, 6095.786647467339, 4702.177119004161, 4707.270373092159, 4711.458182309044, 4724.551167639077, 4728.196206644861, 4511.2406161597, 4681.508441613632, 4705.623550115983, 4709.0, 4722.64580156488, 4572.359869618256, 4594.655400844933, 4601.976990115045, 4623.884402889921, 4647.86056418308, 4665.0, 4675.812967481296, 4703.576678098971, 4704.9059018819435, 4712.057588482283, 4149.294619914592, 4163.084121493297, 4168.270552653304, 4170.666346692287, 4170.77060761658, 5662.688552129631, 5784.623999440065, 5798.0, 5799.18811366409, 5802.158686990363, 5419.0, 5420.810271640513, 5421.539169170625, 5427.62006659534, 5428.891422171534, 6537.771178008747, 6544.443722283611, 6546.770863019819, 6547.050677651761, 6549.246836613803, 4502.729836209838, 4503.797329120198, 4510.774461276956, 4514.774261286955, 4530.252508336153, 6599.571027883172, 6658.234303055162, 6743.291954344772, 6743.4942379321255, 6744.190697116328, 4654.743989080565, 4661.184292748755, 4663.580277775017, 4666.743329116931, 4673.532646735299, 4716.0, 4723.5984941279685, 4729.101470720552, 4731.030138821533, 4732.077244937204, 5429.4027656957705, 5439.048166570834, 5443.156310771837, 5444.210589464506, 5447.945520544744, 6403.199600049994, 6570.375814297634, 6571.21145462538, 6576.408123268833, 6579.671016449159, 1631.7062928672715, 1635.5175223309152, 1637.1241385858746, 1637.6315329051106, 1641.3680732917674, 1090.9509072091776, 1091.9727006824894, 1093.7265683579105, 1109.2013750099916, 1110.9166812489095, 6192.535559833031, 6272.341404152589, 6275.843103922439, 6286.245650521967, 6288.245410550763, 6625.503087268474, 6681.098051763047, 6755.0, 6768.120144381297, 6771.221309549464, 6155.507559395238, 6231.376862313732, 6272.435480806749, 6317.084022816666, 6326.525510586633, 3627.9637203628154, 3659.579148397915, 3669.3945498992366, 3672.3940549809518, 3673.834677439522, 6834.897476537856, 6974.755883544051, 6986.44108471321, 6995.440364770806, 7001.124859392576, 6947.235804061549, 6953.965230173918, 6955.930440695528, 6958.095447591781, 6965.825854353681, 6978.197507286625, 6986.54587451814, 6989.26612705679, 6989.790306290819, 6991.056207412036, 6626.83432914181, 6781.93218067813, 6803.217629972616, 6814.420774234246, 6819.283975182733, 6704.463642908653, 6711.4966377520905, 6713.362230588086, 6714.630695311805, 6715.93284067153, 6975.0, 6985.0, 6985.755498557526, 6992.021117043516, 6994.61529615876, 4599.103174881, 4675.836345727883, 4682.0, 4683.297505374221, 4701.294805779024, 6800.897986530107, 6816.0457535946, 6822.897656535057, 6826.283240259701, 6832.350926661959, 6627.403533681992, 6639.070530125689, 6641.236257830411, 6644.833879152867, 6645.0696902434665, 6535.117759102461, 6568.343165683394, 6615.834604134935, 6627.304133065959, 6648.268690444144, 6498.545101842826, 6515.478761699147, 6515.576487528296, 6515.967420162869, 6516.674166291761, 6609.570377925419, 6644.169478815148, 6650.501212409185, 6651.4013738761805, 6659.2008958925235, 6274.560780745304, 6473.870522589427, 6474.028895665688, 6496.382843629847, 6535.57518761279], "unit": "ms", "name": "prototype.html", "value": 4936.995323638055}, {"lowerIsBetter": false, "replicates": [804.0994086622983, 828.7596596986874, 919.8528235482322, 922.5064590444113, 949.8860136783587, 13338.199708017513, 13605.795913061313, 13630.931845340785, 13636.318184090806, 13690.794638080437, 13590.728185436285, 13752.656183595414, 13806.723865522683, 13818.930905345484, 13844.446222151102, 894.516960841145, 902.1204325782343, 905.0858632780905, 905.108468158863, 905.4612505559214, 910.8360495110877, 920.0293690156882, 920.1350730313517, 920.3603495570582, 920.9907900920972, 945.3666043750669, 951.9286053546011, 952.5570609666504, 953.1516949914547, 953.7043516509904, 940.9247260219166, 946.6497395963469, 946.8911075226368, 948.6442584030989, 948.7533241357262, 689.9482538809559, 690.3683129936103, 690.5338896245014, 690.7375197424997, 692.4737199728243, 13122.34388280582, 13190.0, 13209.33953302331, 13217.273049982246, 13249.73500529984, 11273.774524509465, 11591.536338546448, 11719.882801171965, 11789.823152652718, 11939.104567157498, 9797.363171393836, 9882.950585247028, 10019.89980100197, 10066.29535932485, 10239.48802559869, 3573.928521429557, 3610.151614370621, 3617.981910090459, 3627.2382799612114, 3630.2739452109417, 45945.770271148765, 46258.30612540815, 46467.76766116148, 48234.99999999965, 48286.27570586444, 10062.19502439803, 10090.747731306776, 10121.1903047756, 10431.530581123716, 10614.522346494427, 17964.640707185783, 18000.639987200182, 18037.27850885976, 18274.26902923895, 18279.817201827813, 8013.278804907586, 8060.758177254575, 8212.425130240827, 8240.299574536111, 8512.021117571434, 4237.385579091077, 4287.549807270254, 4311.0, 4336.132773445323, 4422.690411671217, 3205.406999705062, 3217.17961919709, 3219.7263232625487, 3230.789998650127, 3237.3039796443877, 538.9461053894579, 558.7653185662032, 562.3954249182145, 563.0147242325929, 567.3532173322416, 650.7104338569386, 727.3417557110823, 733.3912852332658, 746.6938555192345, 747.7233423633181, 9038.954805226063, 9040.276777857756, 9062.682806101886, 9228.584713687766, 9449.858252126223, 748.9592255442919, 755.3466251692356, 762.3367670127025, 769.1539306762517, 781.4803155901376, 4192.014876504019, 4449.866504004885, 4519.231730605805, 4579.107074120515, 4651.604613607881, 57562.7121864388, 58848.41151588515, 58868.705656471444, 59033.40966590279, 59088.40911590829, 48513.514864851604, 48850.0, 51930.480695192564, 52482.0, 60374.69812650909, 48294.758526207144, 48480.7575962125, 49084.75457622689, 49100.263496047584, 49391.50608493941, 9016.729498115066, 9061.184493395625, 9177.954110229406, 9440.763980900258, 9592.760180995252, 35888.64111358853, 36255.45616815802, 37164.81417592895, 37395.43906841454, 37533.06167345838, 44546.0, 46397.0, 46461.76769116133, 47995.52004479911, 48092.27861582149, 11465.656030319104, 11880.168388213087, 11965.880341196476, 12263.448144833683, 12329.876701232874, 13511.594652160451, 13584.79622805639, 13822.170669759847, 13868.4452621894, 14151.787723184367, 11473.13951453661, 11482.770344592895, 11716.531338746354, 11788.646340609796, 12459.688507787016, 11776.0, 11949.581764638197, 12335.259884406963, 12544.372781360713, 12670.619881403572, 12147.514099436277, 12160.513579457076, 12187.451564679788, 12235.388230588613, 12600.180988235736, 10200.540975655966, 10411.375317480975, 10637.521311540844, 10768.46157692128, 10816.134709223086, 10189.133923616575, 10277.383356998305, 10603.41681207541, 10626.415547144981, 10727.785444291227], "unit": "ms", "name": "yui.html", "value": 6670.637456777391}], "name": "dromaeo_css", "value": 7389.967630715668}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 110.0, 104.0, 110.0, 110.0, 110.0, 101.0, 109.0, 110.0, 109.0], "unit": "ms", "name": "ai-astar", "value": 108.4}, {"lowerIsBetter": true, "replicates": [149.0, 121.0, 147.0, 161.0, 122.0, 146.0, 147.0, 122.0, 167.0, 123.0], "unit": "ms", "name": "audio-beat-detection", "value": 140.5}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 159.0, 160.0, 159.0, 159.0, 160.0, 161.0, 160.0, 158.0], "unit": "ms", "name": "audio-dft", "value": 159.7}, {"lowerIsBetter": true, "replicates": [70.0, 72.0, 72.0, 149.0, 71.0, 71.0, 69.0, 71.0, 154.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 87.0}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 136.0, 93.0, 92.0, 93.0, 133.0, 93.0, 92.0, 136.0], "unit": "ms", "name": "audio-oscillator", "value": 105.5}, {"lowerIsBetter": true, "replicates": [109.0, 111.0, 109.0, 110.0, 110.0, 110.0, 108.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.8}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.1}, {"lowerIsBetter": true, "replicates": [55.0, 55.0, 57.0, 55.0, 56.0, 56.0, 55.0, 56.0, 54.0, 53.0], "unit": "ms", "name": "json-parse-financial", "value": 55.2}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 65.0, 65.0, 65.0, 66.0, 65.0, 65.0, 65.0, 66.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 65.2}, {"lowerIsBetter": true, "replicates": [77.0, 79.0, 80.0, 78.0, 77.0, 78.0, 78.0, 78.0, 78.0, 78.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 78.1}, {"lowerIsBetter": true, "replicates": [113.0, 112.0, 115.0, 127.0, 121.0, 121.0, 119.0, 121.0, 118.0, 115.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 118.2}, {"lowerIsBetter": true, "replicates": [133.0, 134.0, 143.0, 142.0, 142.0, 133.0, 144.0, 142.0, 143.0, 132.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 138.8}, {"lowerIsBetter": true, "replicates": [68.0, 64.0, 65.0, 64.0, 66.0, 65.0, 65.0, 63.0, 64.0, 65.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 64.9}], "name": "kraken", "value": 1471.8}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [172.41379310344828], "unit": "score", "name": "Richards", "value": 204.75160000000005}, {"lowerIsBetter": false, "replicates": [165.0709805216243], "unit": "score", "name": "DeltaBlue", "value": 400.542844}, {"lowerIsBetter": false, "replicates": [280.50490883590464], "unit": "score", "name": "Encrypt", "value": 948.9352650000003}, {"lowerIsBetter": false, "replicates": [5186.5284974093265], "unit": "score", "name": "Decrypt", "value": 51.32161138861136}, {"lowerIsBetter": false, "replicates": [976.5625], "unit": "score", "name": "RayTrace", "value": 757.748736}, {"lowerIsBetter": false, "replicates": [543.1830526887561], "unit": "score", "name": "Earley", "value": 1226.958383}, {"lowerIsBetter": false, "replicates": [10536.842105263158], "unit": "score", "name": "Boyer", "value": 63.25073426573423}, {"lowerIsBetter": false, "replicates": [24238.095238095237], "unit": "score", "name": "RegExp", "value": 37.5848428290766}, {"lowerIsBetter": false, "replicates": [527.9831045406547], "unit": "score", "name": "Splay", "value": 154.34395400000002}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 23107.437360652693}]} 08:52:15 INFO - RETURN: dromaeo_css: 7389.97 08:52:15 INFO - RETURN: kraken: 1471.80 08:52:15 INFO - RETURN: v8_7: 23107.44 08:52:15 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,53,35]]", "result": "23107.44"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,53,35]]", "result": "1471.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,53,35]]", "result": "7389.97"}}} 08:52:15 INFO - Return code: 0 08:52:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 08:52:15 INFO - # TBPL SUCCESS # 08:52:15 INFO - Running post-action listener: _resource_record_post_action 08:52:15 INFO - Running post-run listener: _resource_record_post_run 08:52:16 INFO - Total resource usage - Wall time: 1221s; CPU: 13.0%; Read bytes: 0; Write bytes: 375939072; Read time: 0; Write time: 264552 08:52:16 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 115470336; Read time: 0; Write time: 88860 08:52:17 INFO - run-tests - Wall time: 1207s; CPU: 13.0%; Read bytes: 0; Write bytes: 260468736; Read time: 0; Write time: 175692 08:52:17 INFO - Running post-run listener: _upload_blobber_files 08:52:17 INFO - Blob upload gear active. 08:52:17 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 08:52:17 INFO - Copying logs to upload dir... 08:52:17 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1263.068683 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-01-27 08:52:16.591071) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-27 08:52:16.594875) ========= 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=3a3620fb28aea1604ab609ef000001d2-1453912263.448922-1594766415 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453903643/firefox-45.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009930 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453903643/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-01-27 08:52:16.648732) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-27 08:52:16.649053) ========= 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=3a3620fb28aea1604ab609ef000001d2-1453912263.448922-1594766415 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004499 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-27 08:52:16.699927) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-27 08:52:16.700227) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-27 08:52:16.700549) ========= ========= Total master_lag: 0.28 =========