builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-064 starttime: 1452178177.27 results: success (0) buildid: 20160107043001 builduid: 022644d1bf0e4907a3f233df5a2efb4d revision: e0bcd16e1d4b99ba3e542149d0d41e0f60c54b5c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-07 06:49:37.270047) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-07 06:49:37.270596) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-07 06:49:37.270945) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1452172380.565067-985256072 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006418 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-07 06:49:37.294792) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-07 06:49:37.295160) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-07 06:49:37.308893) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 06:49:37.309299) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1452172380.565067-985256072 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004700 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 06:49:37.359512) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-07 06:49:37.359894) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-07 06:49:37.360414) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 06:49:37.360773) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1452172380.565067-985256072 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-07 06:49:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 227M=0s 2016-01-07 06:49:38 (227 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.123430 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 06:49:37.497182) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 06:49:37.497561) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1452172380.565067-985256072 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021097 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 06:49:37.547348) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 06:49:37.547757) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e0bcd16e1d4b99ba3e542149d0d41e0f60c54b5c --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev e0bcd16e1d4b99ba3e542149d0d41e0f60c54b5c --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=a12cd81e0ef515edd9e0d800000001bb-1452172380.565067-985256072 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-07 06:49:39,093 truncating revision to first 12 chars 2016-01-07 06:49:39,093 Setting DEBUG logging. 2016-01-07 06:49:39,093 attempt 1/10 2016-01-07 06:49:39,093 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e0bcd16e1d4b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-07 06:49:39,313 unpacking tar archive at: mozilla-central-e0bcd16e1d4b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.541693 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 06:49:38.102944) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-07 06:49:38.103330) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-07 06:49:38.111100) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-07 06:49:38.111488) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-07 06:49:38.111970) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-01-07 06:49:38.112319) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=a12cd81e0ef515edd9e0d800000001bb-1452172380.565067-985256072 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:49:39 INFO - MultiFileLogger online at 20160107 06:49:39 in /builds/slave/test-pgo 06:49:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 06:49:39 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 06:49:39 INFO - {'append_to_log': False, 06:49:39 INFO - 'base_work_dir': '/builds/slave/test-pgo', 06:49:39 INFO - 'blob_upload_branch': 'Firefox', 06:49:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 06:49:39 INFO - 'branch': 'Firefox', 06:49:39 INFO - 'buildbot_json_path': 'buildprops.json', 06:49:39 INFO - 'config_files': ('talos/linux_config.py',), 06:49:39 INFO - 'default_actions': ('clobber', 06:49:39 INFO - 'read-buildbot-config', 06:49:39 INFO - 'download-and-extract', 06:49:39 INFO - 'populate-webroot', 06:49:39 INFO - 'create-virtualenv', 06:49:39 INFO - 'install', 06:49:39 INFO - 'run-tests'), 06:49:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:49:39 INFO - 'download_minidump_stackwalk': True, 06:49:39 INFO - 'download_symbols': 'ondemand', 06:49:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:49:39 INFO - 'tooltool.py': '/tools/tooltool.py', 06:49:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:49:39 INFO - '/tools/misc-python/virtualenv.py')}, 06:49:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:49:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:49:39 INFO - 'installer_path': 'installer.exe', 06:49:39 INFO - 'log_level': 'info', 06:49:39 INFO - 'log_name': 'talos', 06:49:39 INFO - 'log_to_console': True, 06:49:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:49:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:49:39 INFO - 'opt_config_files': (), 06:49:39 INFO - 'pip_index': False, 06:49:39 INFO - 'sps_profile': False, 06:49:39 INFO - 'sps_profile_interval': 0, 06:49:39 INFO - 'suite': 'dromaeojs', 06:49:39 INFO - 'system_bits': '32', 06:49:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:49:39 INFO - 'title': 'talos-linux64-ix-064', 06:49:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:49:39 INFO - 'use_talos_json': True, 06:49:39 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 06:49:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:49:39 INFO - 'work_dir': 'build'} 06:49:39 INFO - ##### 06:49:39 INFO - ##### Running clobber step. 06:49:39 INFO - ##### 06:49:39 INFO - Running pre-action listener: _resource_record_pre_action 06:49:39 INFO - Running main action method: clobber 06:49:39 INFO - rmtree: /builds/slave/test-pgo/build 06:49:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 06:49:40 INFO - Running post-action listener: _resource_record_post_action 06:49:40 INFO - ##### 06:49:40 INFO - ##### Running read-buildbot-config step. 06:49:40 INFO - ##### 06:49:40 INFO - Running pre-action listener: _resource_record_pre_action 06:49:40 INFO - Running main action method: read_buildbot_config 06:49:40 INFO - Using buildbot properties: 06:49:40 INFO - { 06:49:40 INFO - "project": "", 06:49:40 INFO - "product": "firefox", 06:49:40 INFO - "script_repo_revision": "production", 06:49:40 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 06:49:40 INFO - "repository": "", 06:49:40 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 06:49:40 INFO - "buildid": "20160107043001", 06:49:40 INFO - "pgo_build": "True", 06:49:40 INFO - "basedir": "/builds/slave/test-pgo", 06:49:40 INFO - "buildnumber": 295, 06:49:40 INFO - "slavename": "talos-linux64-ix-064", 06:49:40 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:49:40 INFO - "platform": "ubuntu64_hw", 06:49:40 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 06:49:40 INFO - "branch": "mozilla-central", 06:49:40 INFO - "repo_path": "mozilla-central", 06:49:40 INFO - "revision": "e0bcd16e1d4b99ba3e542149d0d41e0f60c54b5c", 06:49:40 INFO - "stage_platform": "linux64-pgo", 06:49:40 INFO - "builduid": "022644d1bf0e4907a3f233df5a2efb4d", 06:49:40 INFO - "slavebuilddir": "test" 06:49:40 INFO - } 06:49:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZRitCUtFTVa9LyEsFM33UA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 06:49:40 INFO - Running post-action listener: _resource_record_post_action 06:49:40 INFO - ##### 06:49:40 INFO - ##### Running download-and-extract step. 06:49:40 INFO - ##### 06:49:40 INFO - Running pre-action listener: _resource_record_pre_action 06:49:40 INFO - Running main action method: download_and_extract 06:49:40 INFO - mkdir: /builds/slave/test-pgo/build/tests 06:49:40 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')]} 06:49:40 INFO - https://queue.taskcluster.net/v1/task/ZRitCUtFTVa9LyEsFM33UA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 06:49:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRitCUtFTVa9LyEsFM33UA/artifacts/public/build/test_packages.json 06:49:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRitCUtFTVa9LyEsFM33UA/artifacts/public/build/test_packages.json 06:49:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRitCUtFTVa9LyEsFM33UA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 06:49:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRitCUtFTVa9LyEsFM33UA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 06:49:42 INFO - Downloaded 1302 bytes. 06:49:42 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 06:49:42 INFO - Using the following test package requirements: 06:49:42 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 06:49:42 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:49:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:49:42 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:49:42 INFO - u'jsshell-linux-x86_64.zip'], 06:49:42 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:49:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:49:42 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 06:49:42 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:49:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:49:42 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:49:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:49:42 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:49:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:49:42 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 06:49:42 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:49:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:49:42 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:49:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:49:42 INFO - https://queue.taskcluster.net/v1/task/ZRitCUtFTVa9LyEsFM33UA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:49:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRitCUtFTVa9LyEsFM33UA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:49:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRitCUtFTVa9LyEsFM33UA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:49:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRitCUtFTVa9LyEsFM33UA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:49:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRitCUtFTVa9LyEsFM33UA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:49:43 INFO - Downloaded 24056361 bytes. 06:49:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 06:49:43 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:49:43 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 06:49:44 INFO - Return code: 0 06:49:44 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:49: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')]} 06:49:44 INFO - https://queue.taskcluster.net/v1/task/ZRitCUtFTVa9LyEsFM33UA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:49:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRitCUtFTVa9LyEsFM33UA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:49:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRitCUtFTVa9LyEsFM33UA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:49:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRitCUtFTVa9LyEsFM33UA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:49:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRitCUtFTVa9LyEsFM33UA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:49:54 INFO - Downloaded 24056361 bytes. 06:49:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 06:49:54 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:49:54 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 06:49:55 INFO - Return code: 0 06:49:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:49:55 INFO - https://queue.taskcluster.net/v1/task/ZRitCUtFTVa9LyEsFM33UA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:49:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRitCUtFTVa9LyEsFM33UA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 06:49:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRitCUtFTVa9LyEsFM33UA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 06:49:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRitCUtFTVa9LyEsFM33UA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 06:49:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRitCUtFTVa9LyEsFM33UA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:49:56 INFO - Downloaded 11132285 bytes. 06:49:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 06:49:56 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 06:49:56 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 06:49:56 INFO - Return code: 0 06:49:56 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')]} 06:49:56 INFO - https://queue.taskcluster.net/v1/task/ZRitCUtFTVa9LyEsFM33UA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:49:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRitCUtFTVa9LyEsFM33UA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:49:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRitCUtFTVa9LyEsFM33UA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:49:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRitCUtFTVa9LyEsFM33UA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:49:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRitCUtFTVa9LyEsFM33UA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:49:58 INFO - Downloaded 55923679 bytes. 06:49:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZRitCUtFTVa9LyEsFM33UA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:49:58 INFO - mkdir: /builds/slave/test-pgo/properties 06:49:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 06:49:58 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 06:49:58 INFO - Contents: 06:49:58 INFO - build_url:https://queue.taskcluster.net/v1/task/ZRitCUtFTVa9LyEsFM33UA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:49:58 INFO - Running post-action listener: _resource_record_post_action 06:49:58 INFO - Running post-action listener: set_extra_try_arguments 06:49:58 INFO - ##### 06:49:58 INFO - ##### Running populate-webroot step. 06:49:58 INFO - ##### 06:49:58 INFO - Running pre-action listener: _resource_record_pre_action 06:49:58 INFO - Running main action method: populate_webroot 06:49:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:49:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:49:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:49:58 INFO - '--tppagecycles', 06:49:58 INFO - '7'], 06:49:58 INFO - 'tests': ['tsvgm']}}, 06:49:58 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:49:58 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:49:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:49:58 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:49:58 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:49:58 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:49:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:49:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:49:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:49:58 INFO - 'talos_options': ['--e10s'], 06:49:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:49:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:49:58 INFO - 'tests': ['damp', 'tps']}, 06:49:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:49:58 INFO - 'talos_options': ['--e10s'], 06:49:58 INFO - 'tests': ['damp', 'tps']}, 06:49:58 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:49:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:49:58 INFO - 'other': {'tests': ['a11yr', 06:49:58 INFO - 'ts_paint', 06:49:58 INFO - 'tpaint', 06:49:58 INFO - 'sessionrestore', 06:49:58 INFO - 'sessionrestore_no_auto_restore']}, 06:49:58 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:49:58 INFO - 'tests': ['a11yr', 06:49:58 INFO - 'ts_paint', 06:49:58 INFO - 'tpaint', 06:49:58 INFO - 'sessionrestore', 06:49:58 INFO - 'sessionrestore_no_auto_restore']}, 06:49:58 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:49:58 INFO - 'tests': ['a11yr', 06:49:58 INFO - 'ts_paint', 06:49:58 INFO - 'tpaint', 06:49:58 INFO - 'sessionrestore', 06:49:58 INFO - 'sessionrestore_no_auto_restore']}, 06:49:58 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:49:58 INFO - 'tests': ['a11yr', 06:49:58 INFO - 'ts_paint', 06:49:58 INFO - 'tpaint', 06:49:58 INFO - 'sessionrestore', 06:49:58 INFO - 'sessionrestore_no_auto_restore']}, 06:49:58 INFO - 'other_l64': {'tests': ['a11yr', 06:49:58 INFO - 'ts_paint', 06:49:58 INFO - 'tpaint', 06:49:58 INFO - 'sessionrestore', 06:49:58 INFO - 'sessionrestore_no_auto_restore']}, 06:49:58 INFO - 'other_nol64': {'tests': ['a11yr', 06:49:58 INFO - 'ts_paint', 06:49:58 INFO - 'tpaint', 06:49:58 INFO - 'sessionrestore', 06:49:58 INFO - 'sessionrestore_no_auto_restore']}, 06:49:58 INFO - 'svgr': {'tests': ['tsvgx', 06:49:58 INFO - 'tsvgr_opacity', 06:49:58 INFO - 'tart', 06:49:58 INFO - 'tscrollx', 06:49:58 INFO - 'cart']}, 06:49:58 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:49:58 INFO - 'tests': ['tsvgx', 06:49:58 INFO - 'tsvgr_opacity', 06:49:58 INFO - 'tart', 06:49:58 INFO - 'tscrollx', 06:49:58 INFO - 'cart']}, 06:49:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:49:58 INFO - 'tests': ['tp5o']}, 06:49:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:49:58 INFO - 'talos_options': ['--e10s'], 06:49:58 INFO - 'tests': ['tp5o']}, 06:49:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:49:58 INFO - 'talos_options': ['--xperf_path', 06:49:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:49:58 INFO - 'tests': ['tp5n']}, 06:49:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:49:58 INFO - 'talos_options': ['--e10s', 06:49:58 INFO - '--xperf_path', 06:49:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:49:58 INFO - 'tests': ['tp5n']}}, 06:49:58 INFO - 'talos.zip': {'path': '', 06:49:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:49:58 INFO - Running post-action listener: _resource_record_post_action 06:49:58 INFO - ##### 06:49:58 INFO - ##### Running create-virtualenv step. 06:49:58 INFO - ##### 06:49:58 INFO - Running pre-action listener: _resource_record_pre_action 06:49:58 INFO - Running main action method: create_virtualenv 06:49:58 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 06:49:58 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 06:49:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 06:49:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:49:58 INFO - Using real prefix '/usr' 06:49:58 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 06:49:58 INFO - Installing distribute.............................................................................................................................................................................................done. 06:50:00 INFO - Installing pip.................done. 06:50:00 INFO - Return code: 0 06:50:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 06:50:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:00 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f38b8a9bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a1630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2532840>, '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 0x249f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x249fb60>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1452172380.565067-985256072', '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 06:50:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 06:50:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 06:50:00 INFO - Using env: {'DISPLAY': ':0', 06:50:00 INFO - 'HOME': '/home/cltbld', 06:50:00 INFO - 'LANG': 'en_US.UTF-8', 06:50:00 INFO - 'LANGUAGE': 'en_US:en', 06:50:00 INFO - 'LOGNAME': 'cltbld', 06:50:00 INFO - 'MAIL': '/var/mail/cltbld', 06:50:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:00 INFO - 'MOZ_NO_REMOTE': '1', 06:50:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:00 INFO - 'NO_EM_RESTART': '1', 06:50:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:50:00 INFO - 'PWD': '/builds/slave/test-pgo', 06:50:00 INFO - 'SHELL': '/bin/bash', 06:50:00 INFO - 'SHLVL': '1', 06:50:00 INFO - 'TERM': 'linux', 06:50:00 INFO - 'TMOUT': '86400', 06:50:00 INFO - 'USER': 'cltbld', 06:50:00 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1452172380.565067-985256072', 06:50:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:00 INFO - '_': '/tools/buildbot/bin/python'} 06:50:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:00 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 06:50:00 INFO - Cleaning up... 06:50:00 INFO - Return code: 0 06:50:00 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 06:50:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:00 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f38b8a9bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a1630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2532840>, '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 0x249f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x249fb60>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1452172380.565067-985256072', '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 06:50:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 06:50:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 06:50:00 INFO - Using env: {'DISPLAY': ':0', 06:50:00 INFO - 'HOME': '/home/cltbld', 06:50:00 INFO - 'LANG': 'en_US.UTF-8', 06:50:00 INFO - 'LANGUAGE': 'en_US:en', 06:50:00 INFO - 'LOGNAME': 'cltbld', 06:50:00 INFO - 'MAIL': '/var/mail/cltbld', 06:50:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:00 INFO - 'MOZ_NO_REMOTE': '1', 06:50:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:00 INFO - 'NO_EM_RESTART': '1', 06:50:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:50:00 INFO - 'PWD': '/builds/slave/test-pgo', 06:50:00 INFO - 'SHELL': '/bin/bash', 06:50:00 INFO - 'SHLVL': '1', 06:50:00 INFO - 'TERM': 'linux', 06:50:00 INFO - 'TMOUT': '86400', 06:50:00 INFO - 'USER': 'cltbld', 06:50:00 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1452172380.565067-985256072', 06:50:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:00 INFO - '_': '/tools/buildbot/bin/python'} 06:50:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:01 INFO - Downloading/unpacking psutil>=0.7.1 06:50:01 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 06:50:01 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 06:50:01 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 06:50:01 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 06:50:01 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 06:50:01 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 06:50:02 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 06:50:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 06:50:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 06:50:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:50:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:50:03 INFO - Installing collected packages: psutil 06:50:03 INFO - Running setup.py install for psutil 06:50:03 INFO - building 'psutil._psutil_linux' extension 06:50:03 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 06:50:03 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 06:50:03 INFO - building 'psutil._psutil_posix' extension 06:50:03 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 06:50:03 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 06:50:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:50:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:50:03 INFO - Successfully installed psutil 06:50:03 INFO - Cleaning up... 06:50:03 INFO - Return code: 0 06:50:03 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 06:50:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:03 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f38b8a9bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a1630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2532840>, '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 0x249f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x249fb60>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1452172380.565067-985256072', '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 06:50:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 06:50:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 06:50:03 INFO - Using env: {'DISPLAY': ':0', 06:50:03 INFO - 'HOME': '/home/cltbld', 06:50:03 INFO - 'LANG': 'en_US.UTF-8', 06:50:03 INFO - 'LANGUAGE': 'en_US:en', 06:50:03 INFO - 'LOGNAME': 'cltbld', 06:50:03 INFO - 'MAIL': '/var/mail/cltbld', 06:50:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:03 INFO - 'MOZ_NO_REMOTE': '1', 06:50:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:03 INFO - 'NO_EM_RESTART': '1', 06:50:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:50:03 INFO - 'PWD': '/builds/slave/test-pgo', 06:50:03 INFO - 'SHELL': '/bin/bash', 06:50:03 INFO - 'SHLVL': '1', 06:50:03 INFO - 'TERM': 'linux', 06:50:03 INFO - 'TMOUT': '86400', 06:50:03 INFO - 'USER': 'cltbld', 06:50:03 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1452172380.565067-985256072', 06:50:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:03 INFO - '_': '/tools/buildbot/bin/python'} 06:50:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:03 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:50:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:05 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:50:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 06:50:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:50:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:50:05 INFO - Installing collected packages: mozsystemmonitor 06:50:05 INFO - Running setup.py install for mozsystemmonitor 06:50:05 INFO - Successfully installed mozsystemmonitor 06:50:05 INFO - Cleaning up... 06:50:05 INFO - Return code: 0 06:50:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 06:50:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:05 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f38b8a9bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a1630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2532840>, '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 0x249f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x249fb60>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1452172380.565067-985256072', '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 06:50:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 06:50:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 06:50:05 INFO - Using env: {'DISPLAY': ':0', 06:50:05 INFO - 'HOME': '/home/cltbld', 06:50:05 INFO - 'LANG': 'en_US.UTF-8', 06:50:05 INFO - 'LANGUAGE': 'en_US:en', 06:50:05 INFO - 'LOGNAME': 'cltbld', 06:50:05 INFO - 'MAIL': '/var/mail/cltbld', 06:50:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:05 INFO - 'MOZ_NO_REMOTE': '1', 06:50:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:05 INFO - 'NO_EM_RESTART': '1', 06:50:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:50:05 INFO - 'PWD': '/builds/slave/test-pgo', 06:50:05 INFO - 'SHELL': '/bin/bash', 06:50:05 INFO - 'SHLVL': '1', 06:50:05 INFO - 'TERM': 'linux', 06:50:05 INFO - 'TMOUT': '86400', 06:50:05 INFO - 'USER': 'cltbld', 06:50:05 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1452172380.565067-985256072', 06:50:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:05 INFO - '_': '/tools/buildbot/bin/python'} 06:50:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:05 INFO - Downloading/unpacking blobuploader==1.2.4 06:50:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:07 INFO - Downloading blobuploader-1.2.4.tar.gz 06:50:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 06:50:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:50:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:50:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 06:50:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 06:50:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:50:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:08 INFO - Downloading docopt-0.6.1.tar.gz 06:50:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 06:50:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 06:50:08 INFO - Installing collected packages: blobuploader, requests, docopt 06:50:08 INFO - Running setup.py install for blobuploader 06:50:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:50:08 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 06:50:08 INFO - Running setup.py install for requests 06:50:08 INFO - Running setup.py install for docopt 06:50:09 INFO - Successfully installed blobuploader requests docopt 06:50:09 INFO - Cleaning up... 06:50:09 INFO - Return code: 0 06:50:09 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:50: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')]} 06:50:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50: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')]} 06:50:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:09 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f38b8a9bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a1630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2532840>, '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 0x249f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x249fb60>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1452172380.565067-985256072', '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 06:50:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 06:50:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --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 06:50:09 INFO - Using env: {'DISPLAY': ':0', 06:50:09 INFO - 'HOME': '/home/cltbld', 06:50:09 INFO - 'LANG': 'en_US.UTF-8', 06:50:09 INFO - 'LANGUAGE': 'en_US:en', 06:50:09 INFO - 'LOGNAME': 'cltbld', 06:50:09 INFO - 'MAIL': '/var/mail/cltbld', 06:50:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:09 INFO - 'MOZ_NO_REMOTE': '1', 06:50:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:09 INFO - 'NO_EM_RESTART': '1', 06:50:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:50:09 INFO - 'PWD': '/builds/slave/test-pgo', 06:50:09 INFO - 'SHELL': '/bin/bash', 06:50:09 INFO - 'SHLVL': '1', 06:50:09 INFO - 'TERM': 'linux', 06:50:09 INFO - 'TMOUT': '86400', 06:50:09 INFO - 'USER': 'cltbld', 06:50:09 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1452172380.565067-985256072', 06:50:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:09 INFO - '_': '/tools/buildbot/bin/python'} 06:50:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:50:09 INFO - Running setup.py (path:/tmp/pip-r_8HeH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:50:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:50:09 INFO - Running setup.py (path:/tmp/pip-7mWDd3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:50:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:50:09 INFO - Running setup.py (path:/tmp/pip-SEiepi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:50:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:50:09 INFO - Running setup.py (path:/tmp/pip-W2Byex-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:50:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 06:50:09 INFO - Running setup.py (path:/tmp/pip-O0LHzN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 06:50:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:50:09 INFO - Running setup.py (path:/tmp/pip-10rNXR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:50:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:50:09 INFO - Running setup.py (path:/tmp/pip-GxkJX8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:50:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:50:09 INFO - Running setup.py (path:/tmp/pip-UBP9Lj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:50:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 06:50:09 INFO - Running setup.py (path:/tmp/pip-KwC5z7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 06:50:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 06:50:09 INFO - Running setup.py (path:/tmp/pip-yzEtgh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 06:50:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:50:10 INFO - Running setup.py (path:/tmp/pip-MxluP4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:50:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:50:10 INFO - Running setup.py (path:/tmp/pip-ttBXUI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:50:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:50:10 INFO - Running setup.py (path:/tmp/pip-5XfHmq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:50:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:50:10 INFO - Running setup.py (path:/tmp/pip-mmG6Cb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:50:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:50:10 INFO - Running setup.py (path:/tmp/pip-Y45KPE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:50:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 06:50:10 INFO - Running setup.py (path:/tmp/pip-IHlgGi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 06:50:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 06:50:10 INFO - Running setup.py (path:/tmp/pip-RqXIwU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 06:50:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:50:10 INFO - Running setup.py install for manifestparser 06:50:10 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 06:50:10 INFO - Running setup.py install for mozcrash 06:50:10 INFO - Running setup.py install for mozdebug 06:50:10 INFO - Running setup.py install for mozdevice 06:50:10 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 06:50:10 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 06:50:10 INFO - Running setup.py install for mozfile 06:50:11 INFO - Running setup.py install for mozhttpd 06:50:11 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 06:50:11 INFO - Running setup.py install for mozinfo 06:50:11 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 06:50:11 INFO - Running setup.py install for mozInstall 06:50:11 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 06:50:11 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 06:50:11 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 06:50:11 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 06:50:11 INFO - Running setup.py install for mozleak 06:50:11 INFO - Running setup.py install for mozlog 06:50:11 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 06:50:11 INFO - Running setup.py install for moznetwork 06:50:11 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 06:50:11 INFO - Running setup.py install for mozprocess 06:50:11 INFO - Running setup.py install for mozprofile 06:50:11 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 06:50:11 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 06:50:11 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 06:50:11 INFO - Running setup.py install for mozrunner 06:50:11 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 06:50:12 INFO - Running setup.py install for mozscreenshot 06:50:12 INFO - Running setup.py install for moztest 06:50:12 INFO - Running setup.py install for mozversion 06:50:12 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 06:50:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:50:12 INFO - Cleaning up... 06:50:12 INFO - Return code: 0 06:50:12 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:50:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:12 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f38b8a9bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a1630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2532840>, '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 0x249f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x249fb60>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1452172380.565067-985256072', '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 06:50:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 06:50:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 06:50:12 INFO - Using env: {'DISPLAY': ':0', 06:50:12 INFO - 'HOME': '/home/cltbld', 06:50:12 INFO - 'LANG': 'en_US.UTF-8', 06:50:12 INFO - 'LANGUAGE': 'en_US:en', 06:50:12 INFO - 'LOGNAME': 'cltbld', 06:50:12 INFO - 'MAIL': '/var/mail/cltbld', 06:50:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:12 INFO - 'MOZ_NO_REMOTE': '1', 06:50:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:12 INFO - 'NO_EM_RESTART': '1', 06:50:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:50:12 INFO - 'PWD': '/builds/slave/test-pgo', 06:50:12 INFO - 'SHELL': '/bin/bash', 06:50:12 INFO - 'SHLVL': '1', 06:50:12 INFO - 'TERM': 'linux', 06:50:12 INFO - 'TMOUT': '86400', 06:50:12 INFO - 'USER': 'cltbld', 06:50:12 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1452172380.565067-985256072', 06:50:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:12 INFO - '_': '/tools/buildbot/bin/python'} 06:50:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:50:12 INFO - Running setup.py (path:/tmp/pip-8KPRBx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:50:12 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)) 06:50:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:50:12 INFO - Running setup.py (path:/tmp/pip-Z3vVPC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:50:12 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)) 06:50:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:50:12 INFO - Running setup.py (path:/tmp/pip-CX2VEk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:50:12 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)) 06:50:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:50:12 INFO - Running setup.py (path:/tmp/pip-eR47uJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:50:12 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)) 06:50:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 06:50:12 INFO - Running setup.py (path:/tmp/pip-xub_0S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 06:50:12 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)) 06:50:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:50:12 INFO - Running setup.py (path:/tmp/pip-09Q4JU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:50:12 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)) 06:50:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:50:12 INFO - Running setup.py (path:/tmp/pip-8kCtTE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:50:13 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)) 06:50:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:50:13 INFO - Running setup.py (path:/tmp/pip-gabrzH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:50:13 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)) 06:50:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 06:50:13 INFO - Running setup.py (path:/tmp/pip-Qifbr5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 06:50:13 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)) 06:50:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 06:50:13 INFO - Running setup.py (path:/tmp/pip-bbTIFl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 06:50:13 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)) 06:50:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:50:13 INFO - Running setup.py (path:/tmp/pip-rKmi0n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:50:13 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)) 06:50:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:50:13 INFO - Running setup.py (path:/tmp/pip-Xod0iI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:50:13 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)) 06:50:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:50:13 INFO - Running setup.py (path:/tmp/pip-bGdu_3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:50:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 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)) 06:50:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:50:13 INFO - Running setup.py (path:/tmp/pip-5UfoDA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:50:13 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)) 06:50:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:50:13 INFO - Running setup.py (path:/tmp/pip-KpIPpb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:50:13 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)) 06:50:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 06:50:13 INFO - Running setup.py (path:/tmp/pip-zxdBOG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 06:50:13 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)) 06:50:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 06:50:13 INFO - Running setup.py (path:/tmp/pip-a9WJE6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 06:50:13 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)) 06:50:13 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)) 06:50:13 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)) 06:50:13 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)) 06:50:13 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)) 06:50:13 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)) 06:50:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 06:50:13 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 06:50:13 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 06:50:13 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 06:50:13 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 06:50:13 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 06:50:13 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 06:50:15 INFO - Downloading blessings-1.5.1.tar.gz 06:50:15 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 06:50:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 06:50:15 INFO - Installing collected packages: blessings 06:50:15 INFO - Running setup.py install for blessings 06:50:15 INFO - Successfully installed blessings 06:50:15 INFO - Cleaning up... 06:50:15 INFO - Return code: 0 06:50:15 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 06:50:15 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 06:50:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 06:50:15 INFO - Reading from file tmpfile_stdout 06:50:15 INFO - Current package versions: 06:50:15 INFO - argparse == 1.2.1 06:50:15 INFO - blessings == 1.5.1 06:50:15 INFO - blobuploader == 1.2.4 06:50:15 INFO - docopt == 0.6.1 06:50:15 INFO - manifestparser == 1.1 06:50:15 INFO - mozInstall == 1.12 06:50:15 INFO - mozcrash == 0.16 06:50:15 INFO - mozdebug == 0.1 06:50:15 INFO - mozdevice == 0.47 06:50:15 INFO - mozfile == 1.2 06:50:15 INFO - mozhttpd == 0.7 06:50:15 INFO - mozinfo == 0.9 06:50:15 INFO - mozleak == 0.1 06:50:15 INFO - mozlog == 3.1 06:50:15 INFO - moznetwork == 0.27 06:50:15 INFO - mozprocess == 0.22 06:50:15 INFO - mozprofile == 0.28 06:50:15 INFO - mozrunner == 6.11 06:50:15 INFO - mozscreenshot == 0.1 06:50:15 INFO - mozsystemmonitor == 0.0 06:50:15 INFO - moztest == 0.7 06:50:15 INFO - mozversion == 1.4 06:50:15 INFO - psutil == 3.1.1 06:50:15 INFO - requests == 1.2.3 06:50:15 INFO - wsgiref == 0.1.2 06:50:15 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:50: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')]} 06:50:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50: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')]} 06:50:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:15 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f38b8a9bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a1630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2532840>, '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 0x249f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x249fb60>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1452172380.565067-985256072', '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 06:50:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 06:50:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 06:50:15 INFO - Using env: {'DISPLAY': ':0', 06:50:15 INFO - 'HOME': '/home/cltbld', 06:50:15 INFO - 'LANG': 'en_US.UTF-8', 06:50:15 INFO - 'LANGUAGE': 'en_US:en', 06:50:15 INFO - 'LOGNAME': 'cltbld', 06:50:15 INFO - 'MAIL': '/var/mail/cltbld', 06:50:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:15 INFO - 'MOZ_NO_REMOTE': '1', 06:50:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:15 INFO - 'NO_EM_RESTART': '1', 06:50:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:50:15 INFO - 'PWD': '/builds/slave/test-pgo', 06:50:15 INFO - 'SHELL': '/bin/bash', 06:50:15 INFO - 'SHLVL': '1', 06:50:15 INFO - 'TERM': 'linux', 06:50:15 INFO - 'TMOUT': '86400', 06:50:15 INFO - 'USER': 'cltbld', 06:50:15 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1452172380.565067-985256072', 06:50:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:15 INFO - '_': '/tools/buildbot/bin/python'} 06:50:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.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 1)) 06:50:16 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 2)) 06:50:16 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 3)) 06:50:16 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 4)) 06:50:16 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 5)) 06:50:16 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 6)) 06:50:16 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 7)) 06:50:16 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 8)) 06:50:16 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 9)) 06:50:16 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.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 06:50:16 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 4)) 06:50:16 INFO - Cleaning up... 06:50:16 INFO - Return code: 0 06:50:16 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 06:50:16 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')]} 06:50:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:16 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')]} 06:50:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:16 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f38b8a9bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a1630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2532840>, '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 0x249f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x249fb60>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1452172380.565067-985256072', '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 06:50:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 06:50:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 06:50:16 INFO - Using env: {'DISPLAY': ':0', 06:50:16 INFO - 'HOME': '/home/cltbld', 06:50:16 INFO - 'LANG': 'en_US.UTF-8', 06:50:16 INFO - 'LANGUAGE': 'en_US:en', 06:50:16 INFO - 'LOGNAME': 'cltbld', 06:50:16 INFO - 'MAIL': '/var/mail/cltbld', 06:50:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:16 INFO - 'MOZ_NO_REMOTE': '1', 06:50:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:16 INFO - 'NO_EM_RESTART': '1', 06:50:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:50:16 INFO - 'PWD': '/builds/slave/test-pgo', 06:50:16 INFO - 'SHELL': '/bin/bash', 06:50:16 INFO - 'SHLVL': '1', 06:50:16 INFO - 'TERM': 'linux', 06:50:16 INFO - 'TMOUT': '86400', 06:50:16 INFO - 'USER': 'cltbld', 06:50:16 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1452172380.565067-985256072', 06:50:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:16 INFO - '_': '/tools/buildbot/bin/python'} 06:50:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:16 INFO - Downloading/unpacking jsonschema 06:50:16 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 06:50:16 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 06:50:16 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 06:50:16 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 06:50:16 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 06:50:16 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 06:50:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:50:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 06:50:18 INFO - Downloading/unpacking functools32 (from jsonschema) 06:50:18 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 06:50:18 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 06:50:18 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 06:50:18 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 06:50:18 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 06:50:18 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 06:50:18 INFO - Downloading functools32-3.2.3-2.tar.gz 06:50:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 06:50:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 06:50:18 INFO - warning: no files found matching '*.txt' 06:50:18 INFO - no previously-included directories found matching 'build' 06:50:18 INFO - no previously-included directories found matching 'dist' 06:50:18 INFO - no previously-included directories found matching '.git*' 06:50:18 INFO - Installing collected packages: jsonschema, functools32 06:50:18 INFO - Running setup.py install for functools32 06:50:18 INFO - warning: no files found matching '*.txt' 06:50:18 INFO - no previously-included directories found matching 'build' 06:50:18 INFO - no previously-included directories found matching 'dist' 06:50:18 INFO - no previously-included directories found matching '.git*' 06:50:18 INFO - Successfully installed jsonschema functools32 06:50:18 INFO - Cleaning up... 06:50:18 INFO - Return code: 0 06:50:18 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 06:50: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')]} 06:50:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50: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')]} 06:50:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:18 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f38b8a9bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a1630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2532840>, '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 0x249f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x249fb60>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1452172380.565067-985256072', '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 06:50:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 06:50:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 06:50:18 INFO - Using env: {'DISPLAY': ':0', 06:50:18 INFO - 'HOME': '/home/cltbld', 06:50:18 INFO - 'LANG': 'en_US.UTF-8', 06:50:18 INFO - 'LANGUAGE': 'en_US:en', 06:50:18 INFO - 'LOGNAME': 'cltbld', 06:50:18 INFO - 'MAIL': '/var/mail/cltbld', 06:50:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:18 INFO - 'MOZ_NO_REMOTE': '1', 06:50:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:18 INFO - 'NO_EM_RESTART': '1', 06:50:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:50:18 INFO - 'PWD': '/builds/slave/test-pgo', 06:50:18 INFO - 'SHELL': '/bin/bash', 06:50:18 INFO - 'SHLVL': '1', 06:50:18 INFO - 'TERM': 'linux', 06:50:18 INFO - 'TMOUT': '86400', 06:50:18 INFO - 'USER': 'cltbld', 06:50:18 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1452172380.565067-985256072', 06:50:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:18 INFO - '_': '/tools/buildbot/bin/python'} 06:50:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:18 INFO - Downloading/unpacking flake8 06:50:18 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 06:50:18 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 06:50:18 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 06:50:18 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 06:50:18 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 06:50:18 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 06:50:20 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:50:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 06:50:20 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:50:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:20 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:50:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 06:50:20 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:50:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 06:50:20 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:50:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 06:50:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 06:50:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:50:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:50:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:50:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:50:21 INFO - no previously-included directories found matching 'docs/_build' 06:50:21 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:50:21 INFO - Running setup.py install for pep8 06:50:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:50:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:50:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:50:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:50:21 INFO - no previously-included directories found matching 'docs/_build' 06:50:21 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 06:50:21 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:50:21 INFO - Cleaning up... 06:50:21 INFO - Return code: 0 06:50:21 INFO - Running post-action listener: _resource_record_post_action 06:50:21 INFO - Running post-action listener: _start_resource_monitoring 06:50:21 INFO - Starting resource monitoring. 06:50:21 INFO - ##### 06:50:21 INFO - ##### Running install step. 06:50:21 INFO - ##### 06:50:21 INFO - Running pre-action listener: _resource_record_pre_action 06:50:21 INFO - Running main action method: install 06:50:21 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 06:50:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 06:50:21 INFO - Reading from file tmpfile_stdout 06:50:21 INFO - Detecting whether we're running mozinstall >=1.0... 06:50:21 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 06:50:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 06:50:21 INFO - Reading from file tmpfile_stdout 06:50:21 INFO - Output received: 06:50:21 INFO - Usage: mozinstall [options] installer 06:50:21 INFO - Options: 06:50:21 INFO - -h, --help show this help message and exit 06:50:21 INFO - -d DEST, --destination=DEST 06:50:21 INFO - Directory to install application into. [default: 06:50:21 INFO - "/builds/slave/test-pgo"] 06:50:21 INFO - --app=APP Application being installed. [default: firefox] 06:50:21 INFO - mkdir: /builds/slave/test-pgo/build/application 06:50:21 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 06:50:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 06:50:37 INFO - Reading from file tmpfile_stdout 06:50:37 INFO - Output received: 06:50:37 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 06:50:37 INFO - Running post-action listener: _resource_record_post_action 06:50:37 INFO - ##### 06:50:37 INFO - ##### Running run-tests step. 06:50:37 INFO - ##### 06:50:37 INFO - Running pre-action listener: _resource_record_pre_action 06:50:37 INFO - Running main action method: run_tests 06:50:37 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 06:50:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 06:50:37 INFO - Python 2.7.3 06:50:37 INFO - Return code: 0 06:50:37 INFO - grabbing minidump binary from tooltool 06:50:37 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')]} 06:50:37 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 0x2532840>, '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 0x249f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x249fb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 06:50:37 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 06:50:37 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 06:50:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:50:37 INFO - Return code: 0 06:50:37 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 06:50:37 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 06:50:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 06:50:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 06:50:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 06:50:37 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 06:50:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 06:50:38 INFO - Return code: 0 06:50:38 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZRitCUtFTVa9LyEsFM33UA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 06:50:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZRitCUtFTVa9LyEsFM33UA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-064 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 06:50:38 INFO - Using env: {'DISPLAY': ':0', 06:50:38 INFO - 'HOME': '/home/cltbld', 06:50:38 INFO - 'LANG': 'en_US.UTF-8', 06:50:38 INFO - 'LANGUAGE': 'en_US:en', 06:50:38 INFO - 'LOGNAME': 'cltbld', 06:50:38 INFO - 'MAIL': '/var/mail/cltbld', 06:50:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 06:50:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 06:50:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:38 INFO - 'MOZ_NO_REMOTE': '1', 06:50:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 06:50:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:38 INFO - 'NO_EM_RESTART': '1', 06:50:38 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:50:38 INFO - 'PWD': '/builds/slave/test-pgo', 06:50:38 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 06:50:38 INFO - 'SHELL': '/bin/bash', 06:50:38 INFO - 'SHLVL': '1', 06:50:38 INFO - 'TERM': 'linux', 06:50:38 INFO - 'TMOUT': '86400', 06:50:38 INFO - 'USER': 'cltbld', 06:50:38 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1452172380.565067-985256072', 06:50:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:38 INFO - '_': '/tools/buildbot/bin/python'} 06:50:38 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZRitCUtFTVa9LyEsFM33UA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 06:50:38 INFO - mozversion application_buildid: 20160107043001 06:50:38 INFO - mozversion application_changeset: e0bcd16e1d4b99ba3e542149d0d41e0f60c54b5c 06:50:39 INFO - mozversion application_display_name: Nightly 06:50:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:50:39 INFO - mozversion application_name: Firefox 06:50:39 INFO - mozversion application_remotingname: firefox 06:50:39 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:50:39 INFO - mozversion application_vendor: Mozilla 06:50:39 INFO - mozversion application_version: 46.0a1 06:50:39 INFO - mozversion platform_buildid: 20160107043001 06:50:39 INFO - mozversion platform_changeset: e0bcd16e1d4b99ba3e542149d0d41e0f60c54b5c 06:50:39 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:50:39 INFO - mozversion platform_version: 46.0a1 06:50:39 INFO - using testdate: 1452178239 06:50:39 INFO - actual date: 1452178239 06:50:39 INFO - starting webserver on 'localhost:38831' 06:50:39 INFO - SUITE-START | Running 3 tests 06:50:39 INFO - TEST-START | dromaeo_css 06:50:39 INFO - operating with platform_type : linux_ 06:50:39 INFO - Initialising browser for dromaeo_css test... 06:50:39 INFO - TEST-INFO | started process 20994 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUVKtrE/profile http://localhost:38831/getInfo.html) 06:50:43 INFO - PROCESS | 20994 | __metrics Screen width/height:1600/1200 06:50:43 INFO - PROCESS | 20994 | colorDepth:24 06:50:43 INFO - PROCESS | 20994 | Browser inner width/height: 1024/697 06:50:43 INFO - PROCESS | 20994 | __metrics 06:50:43 INFO - PROCESS | 20994 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 06:50:43 INFO - PROCESS | 20994 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:50:44 INFO - TEST-INFO | 20994: exit 0 06:50:44 INFO - Browser initialized. 06:50:44 INFO - Running cycle 1/1 for dromaeo_css test... 06:50:44 INFO - TEST-INFO | started process 21089 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUVKtrE/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:50:56 INFO - PROCESS | 21089 | RSS: Main: 150446080 06:50:56 INFO - PROCESS | 21089 | 06:51:47 INFO - PROCESS | 21089 | 1452178307983 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] 06:53:57 INFO - PROCESS | 21089 | Cycle 1(1): loaded http://localhost:38831/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38831/tests/dromaeo/cssquery-ext.html) 06:53:58 INFO - PROCESS | 21089 | RSS: Main: 259514368 06:53:58 INFO - PROCESS | 21089 | 06:57:00 INFO - PROCESS | 21089 | Cycle 1(1): loaded http://localhost:38831/tests/dromaeo/cssquery-ext.html (next: http://localhost:38831/tests/dromaeo/cssquery-jquery.html) 06:57:01 INFO - PROCESS | 21089 | RSS: Main: 243646464 06:57:01 INFO - PROCESS | 21089 | 07:00:03 INFO - PROCESS | 21089 | Cycle 1(1): loaded http://localhost:38831/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38831/tests/dromaeo/cssquery-mootools.html) 07:00:03 INFO - PROCESS | 21089 | RSS: Main: 226058240 07:00:03 INFO - PROCESS | 21089 | 07:03:05 INFO - PROCESS | 21089 | Cycle 1(1): loaded http://localhost:38831/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38831/tests/dromaeo/cssquery-prototype.html) 07:03:06 INFO - PROCESS | 21089 | RSS: Main: 212963328 07:03:06 INFO - PROCESS | 21089 | 07:06:08 INFO - PROCESS | 21089 | Cycle 1(1): loaded http://localhost:38831/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38831/tests/dromaeo/cssquery-yui.html) 07:06:09 INFO - PROCESS | 21089 | RSS: Main: 216797184 07:06:09 INFO - PROCESS | 21089 | 07:09:11 INFO - PROCESS | 21089 | Cycle 1(1): loaded http://localhost:38831/tests/dromaeo/cssquery-yui.html (next: http://localhost:38831/tests/dromaeo/cssquery-dojo.html) 07:09:12 INFO - PROCESS | 21089 | RSS: Main: 291430400 07:09:12 INFO - PROCESS | 21089 | 07:09:12 INFO - PROCESS | 21089 | __start_tp_report 07:09:12 INFO - PROCESS | 21089 | _x_x_mozilla_page_load 07:09:12 INFO - PROCESS | 21089 | _x_x_mozilla_page_load_details 07:09:12 INFO - PROCESS | 21089 | |i|pagename|runs| 07:09:12 INFO - PROCESS | 21089 | |0;dojo.html;3156.8579413926373;3189.8405079746008;3227.596550431196;3230.4185246655607;3258.348330333933;5040.1935690289565;5122.92315615266;5178.818741344054;5195.194744814555;5246.842594722155;5153.201253805666;5172.456892026339;5270.578353731702;5284.101702710539;5286.259923610688;4599;4716;4772.594329481998;4840.467548569654;4879.731614761205;4693.7653117344;4807.687500312486;4846.61227101831;4886.706797592138;4905.215165573509;4674.252119660855;4784.091022705692;4786.473487916326;4794.736289504076;4822.879428014293;4748.311494833264;4755.476897541268;4763.261694437368;4766.618670506386;4793.784279707386;4678.766061696935;4730.645201609858;4749.596284315838;4779.545943135397;4783.832565860213;5087.211482220262;5205.219217117425;5211.7133557654315;5221.73891305437;5257.316548848664;5580.218769372291;5585.05054140793;5590.2732644756325;5590.580706446992;5607.130894711327;5566.192902029183;5614.775408983635;5633.95668020617;5647.181158732002;5680.204771332017;5213.7914483421;5216.843494695166;5217.713025783581;5236.319278493847;5383.892322153535;5794.768209271666;5803;5807.0998995155815;5825.242718446575;5856.677882716406;5490.490115218347;5568.331800184003;5585.329760428694;5601.915971260434;5644.153376993484;5436.40199578054;5564.805231816867;5566.582506311962;5671.347795003545;5676.403977582377;5612.130119831432;5664.20701101846;5677.403872593318;5685.516731077904;5719.942800571941;5570.554355651539;5598;5604.663720176803;5604.6917419541505;5606.85982850432;4255.127698821796;4326.372675961968;4336.696431249846;4359.934600980988;4405.405270288534;3900.9804950975063;3904.9804750976064;3923.0388554804254;3942.664873485786;3944.073142811437;5193.766280517386;5202.297689811902;5203.19350500673;5222.451642577551;5252.527272545489;5480.862978425571;5533.03171944908;5596.972015139898;5624.156376543551;5646.548276137899;5093.516115968977;5102.260172275073;5117.692938423706;5130.281760553526;5131.102057139986;4758.072175925661;4771.498992605796;4774.689645173053;4775.904481910342;4817.78319975602;5660.773569057192;5691.857703557362;5723.656580605094;5735.082386818089;5736.799212027559;5603.55171586264;5625;5632.943670563406;5692.686902220417;5749.108888122348;5831.766729330949;5833.67914764692;5838;5839.620424672383;5850.12248162779;5379.381371142369;5516.696581688046;5579.386267510652;5585.916211256916;5599.384067752625;5590.440955904377;5615.971920140373;5636.661800291996;5712.0860662293835;5774.56690748204;5504.22940788282;5542.861428464159;5543.029969755357;5547.084731019498;5552.111662134039;5422.891542169214;5526.336839579276;5535.750891209825;5535.944640553543;5546.639468434539;5338.4394638563945;5371.5971302153275;5441.29263195782;5458.208559758892;5500.9174862377895;5538.972305138448;5596.636218645775;5596.944030559643;5605.271314729059;5656.773729050957;5322.627416080837;5423.810166644149;5474.233607295061;5483.588730845282;5488.615796894179 07:09:12 INFO - PROCESS | 21089 | |1;ext.html;532.6431291035004;543.2313276713451;548.780487804878;561.8874628236092;568.5224411494344;27498.175054748364;28355;28368.57447138292;36219.27561448769;36737.448938265945;38834.22331553367;39256.80371598145;39313.80343098281;39387.212255754865;39502.20995580087;8401.24388805009;8562.443441176334;8575.828483430327;8575.970883493957;8587.31301495882;7473.215312392175;7627.923720762777;9785.951070244639;9936;9939.850902236472;9633.66282180124;9694.903050969506;9704.514774261293;9707;9708.514574271294;7451.813704657373;7612.467127301091;9905.504724763769;9962.850557241647;10030.799384012278;9840.06519380665;10133.493325333704;10137.543810528545;10137.594496220143;10148.594056237742;35552.466712999325;35690.10774730652;35872.461913071325;36004.63995360039;36054;3183.761217908666;3225.1130938991732;3357.0432426758503;3373.645767194458;3567.5362202913457;27713.445731085467;27963.021294254806;28367;29107.417851643062;30445.543316850264;3940.0804383189993;3959.227950549644;4009.599040095967;4013.4180543821276;4098.4876890388705;250927;252984;253118;253431;254752;52090.21864672033;52846.47153528415;57250.427495725344;58613;58657.70671146617;66707;66851.66574167098;67720.6613966927;67754.32245677579;67811.3218867805;14755.926220368829;15204.847951520564;15254.771178432333;15306.234688265542;15316.463923762614;11590.304581724955;11676.824847627122;11686.883131168579;11697.941510292565;11721.062315014779;18645;18935.81064189368;18983.24067037303;19003.714944275845;19275.22899084021;7856.135825059353;8085.231902969209;8131.2681858633005;8149.429539932266;8208.712695055645;959.1894848852709;984.1192133041031;1015.7968406318618;1062.7130674717782;1078.0728573426848;28051;28109.71890281112;28272.43455130886;28543.57184642232;28571.857140714164;1061.400308825511;1065.2862582070031;1082.3235477826358;1086.1799341497276;1149;14966.551003469913;16089.597760056093;16942.40701575439;17032.233549490054;17065.573360666083;376602;381923;383148;383845;383948;54140.187897181575;54427;54561;54689.72655136699;54710.45289547133;1336.1782503760116;1336.5188532128425;1347.8382594088575;1389.7498450279047;1392.0464481829777;29656.555151673172;30203.848980754956;30445.847770761004;30500.389992200475;30596.388072238875;44482.55517444914;45064;45108;45110.32334515051;45223;291918;293274;295419;296127;296181;27676.72323276822;28586.42827143487;28628.284292892844;28638.856805715837;32045.51931721073;36031.63968360388;40952.13335066636;41260;41270.58729412667;41656.1668766629;33099.66900330966;34197.48703769396;34418.82790586031;34857.47713784245;35205;31167.68832311648;33713.66286337105;34188.82905585556;34436.82781586076;34906.825465872505;31472.68527314789;31615.525767113053;31635.84182079075;31638.050858474282;31746;25614.87192564025;28455;29899.55150672698;31287.374252515277;31856.68143318537;21076.789232107483;21600;21602.351929442142;21604.35186944394;21641.567168656853 07:09:12 INFO - PROCESS | 21089 | |2;jquery.html;356.20210727969356;362.84397708985136;364.59894116471867;365.13463092470846;371.3964807188319;13728.450861965533;13917.23455209963;16273.430429934955;16283;16683;14539.418423263083;15117.092974421543;15195.772063419057;16317.755233671505;16330.591735206626;5348.171033489796;5479.671219726829;5479.945200548003;5480.671159730409;5482.068048431756;4099.795010249491;4207.537170911197;5442.564594832424;5477.233187353754;5821.330546987108;5928.88142237155;5938.0499120140785;5964.671943043131;5980.700964951757;5988.071848863433;5854.707264636772;5919.319278283009;6014.939850601481;6018.337982821908;6022.337542870281;5305.602079844027;5312.2828418163435;5313.734313284359;5317.229001794718;5325.281087053237;19593.314234001886;21453.78546214549;21660.783392166035;21682.56634867294;21761.34715958524;671.9731210751564;672.6872004517874;1077.5959015369237;1585.4847174668164;2416.673749043874;12964.675883102904;13253.006024548198;13368;13436.664083397896;13573.728525429535;1807.548112971757;1826.3516451659602;1833.578276996285;1840.8527317814542;1862.850971922243;60014;62435.06347404747;63479;63553.68223158901;64146;9651.131398174199;9852.16256618181;10063.5471403787;10073.395596264247;10113.494325283706;13495.325233738275;13502.864971350356;13503.662408439868;13511.391987360592;13525.864741352658;7641.159472458025;7701.537907725555;7706.807329816687;7749.535027898231;7852.175521570267;7492.587907665022;7524.849503010018;7559.584222867685;7585.772426827204;7597.658105385271;5975.43233392827;5995.430434108753;6070.514358851281;6089.360617135226;6155.292141403706;1699.6090899093278;1744.5725797179773;1748.414281215807;1786.0712429536568;1818.5817262029807;871.6639406390807;953.3421938862163;957.8084383123264;1046.3617193511952;1095.611058074388;14855.70288594222;17120.486385408458;17798.644027119386;17806.496681802255;17997.910010449865;954.236610711428;966.8114717629994;1016.4714348538866;1035;1065.2543219746208;9682.951585242028;9954.208242516272;10274;10421.53103110362;10462.163026957825;535398;544031;546887;554599;570906;41235;41277;41296.38055429171;79831.20168798354;82731;1144.119028348184;1151.2171723228118;1158.29922896648;1165.8367828504017;1175.8588969323737;15285.541433757006;15565.610859728144;16015.919920400323;16045;16313.184340783151;35243.647563524035;35300.47049294314;36456.27087458183;36639.63360366362;37204;46848.531514684415;48203.276950845066;48366;49992.750036249585;50763;8742.781430464289;9095.226905712823;9182.494962776844;9183.403078799856;9190.540472976458;10703.411312377893;12717;16908.32366705367;17371.82628173702;17394;13754.793678094637;13768.173909565458;13836.930815345859;14055.437782488585;14259.07316024455;13916.304184790517;14056;14263.500777472738;14464.276786160439;14510.927445362706;11196;13574.389152488358;13945.39627942759;13971.860281397056;14092.506762263272;9031.142041506046;9035.638574456949;9049.547522623974;9578.9042109578;9803.558839852367;3086.830224337683;12669.493220271455;14096.859031409555;14540.200288984208;15284.235788210768 07:09:12 INFO - PROCESS | 21089 | |3;mootools.html;1221.1635030004443;1443.6246575890268;1460.335547325967;1559.4775750123708;1692.3230707716905;6606.768763093292;7322.304381083795;7438.404927605799;7439.404847612192;7458.7762367128935;7252.673629686664;7434.665440055197;7437.330640242377;7450.329470347668;7454;1950.473372189515;1984.464194667439;2192.0464597899886;2238.462768935452;2281.863088214712;2266.3087758233733;2272.7727227277305;2274.385915802732;2276.3398614401804;2278.3392816083315;2140.4862832920066;2222.188901051121;2222.2666520048347;2226.0539270809923;2226.866388016716;2211.1266049910278;2242.7196600424945;2245.146844199202;2245.38251980705;2288.599495088361;2274.5223503064376;2286.16554957441;2298.4139044543704;2317.6755254264417;2319.3042087373888;7456;7536.4724469287175;7552.924470755277;7555.508891922007;7562.810929726746;4517.570830771071;4582.358469814229;4606.078784243131;4615.330777037311;4617.12274667812;3007.5639032340187;3050.923726906845;3083.938321233585;3101.550275210082;3173.2384227785396;1024.7489365105523;1031.7730099378125;1033.2560556399455;1063.6489958313816;1103.5585765693706;10105.494725263707;10202.183825293958;10219.386836789741;10232.795344093076;10240.436775977318;3967.662748666338;4107.486564179478;4110.835566577303;4111.177764447122;4198.6431153352305;8443.83112337762;8538.487690738575;8554.871676924851;8577.399582029322;8590.012148602866;4541.205289074399;4588.472325682589;4621.075784843045;4623.029163875556;4625.098105869323;4229.703920725519;4233.724807887477;4270.572942705767;4272.807723652443;4273.423087883096;3199.7361042388593;3214.148250713563;3397.21863971288;3476.322117187124;3535.5580552430947;1062.2404980439023;1078.8489611454402;1087.0542627913608;1088.6081010836092;1092.5575142067476;1009.848522721583;1079.0989523747758;1082.99458502707;1083.5394957143183;1085.6091806949491;6741.1236539249585;7055.2944705529035;7073.363397294268;7076.610786406797;7079;634.80321100459;642.6658137768334;643.1381948189448;651.4397618048474;780.6018930345565;5626.2967129108865;5713.314402271671;5724.542036637059;5726.685032323262;5733.140028995601;8811.691590794291;8830.55847207637;9123.81752364949;9157.771055723528;9262.583183756748;9104.590293436811;9129.863052054225;9152.679656212134;9165.450072995642;9166.266698664223;6777.288384719632;7038.472114591426;7141.57150570957;7218.963905180441;7238.98654188414;6896.241413444617;6939.132608423947;6961.199462061725;6963.512554121163;6984.126984126984;7886.329661978796;7919.722809701633;8092.919070809452;8276.668933242603;8304.377171712267;8277.751667449986;8403.327733781405;8559.443636163629;8572.314214862921;8592.65629374818;6692.83267918306;6693.765718199839;6759.121314229119;6928.445724342141;6950.235474097946;6386.074019267087;6507.381798729113;6775.593464392152;6835.726570937107;6884.105066341343;6553.574017688835;6652.40128388428;6692.765753198614;6768.932310676831;6802.0477133202385;6389.87220255583;6526.24948130971;6527.5757075789925;6601.240857301472;6649.202095748541;6624.171978502687;6629.370209830058;6661.700223489857;6667.333266673294;6670.466362690876;6066.666333351532;6106.6946652668075;6110.205673262625;6138.907916381168;6142.6314421134875;6214.25428948529;6252.874942501034;6260.40526150015;6276.811695649138;6290.150829637941 07:09:12 INFO - PROCESS | 21089 | |4;prototype.html;324.07476654152396;325.31196519361555;328.32365327425504;332.297191440104;338.1090825674347;5947.672877991708;5955.761769529219;5972.671503067335;5998.460138587527;6024.54815888809;5698.116791897252;5763.049096899017;5817.301923769153;5905.025670764318;5926.911096333559;4575.450945886481;4577.29051996941;4584.197765391052;4587.42657167854;4595.425571803525;4409.206342858284;4582.381378513908;4583.404157459526;4586.495485496593;4587.908241835161;4435.379046933432;4457.754823484724;4541.205289074415;4549.11292298002;4563.680542362036;4559.635229181674;4562.634989200856;4569.588737013652;4570.79431425585;4575.58819706228;3975.940360894589;3980.9848488635503;3981.820818063165;4016.598340165989;4023.517177938637;5521.420250873641;5604.523615492688;5608.186812912146;5608.270924779793;5622.381538030813;5311.760970756325;5320.17537281722;5320.255164277004;5328.600354973354;5328.786848526054;6271.372862713738;6275.592086514362;6275.811725648238;6276.905846412307;6280.78017269398;4396.89007774805;4401.471823381215;4404.779761011937;4445.288753799409;4449.488308844459;6306.590071645374;6485.319041500669;6492.837679058014;6525.869482610368;6547.9672601636685;4551.908961820745;4553.635709143261;4554.63562914966;4557.430321209848;4563.361129441881;4610.423697037871;4614.630829533697;4616.146012987608;4616.976915115403;4621.722696638145;5286.60350473716;5288.603354748409;5304.549113325334;5306.204069389545;5314.0700377433795;6195.938040619536;6336.968315158395;6397.200349956255;6397.648129352837;6416.550841441148;1569.50560573419;1577.8027746531684;1581.6045988502874;1582.1772678207267;1582.8258891521923;1056.455925198508;1072.790805792863;1074.3446497636435;1075;1089.7929393415225;5967;6000.519958403317;6001.669908155093;6005.939940600538;6010.549208809357;6503.382178693017;6506.772262970773;6510.934890651033;6511.544191906521;6512.6092434454085;5821.912671309934;5874.647521148745;5954.583179177416;5981.730822112929;5984.521238300926;3512.8243587820507;3533.646635336446;3538.203904121552;3539.592946811098;3544.0608238816735;6793.422559082534;6794.0827988221945;6803.557768745016;6804.21751498584;6815.625140617214;6555.967220163869;6614.86770264592;6698;6701.530892837454;6729.798106056826;6809.863802723918;6814.761483348059;6822.147231596051;6825.317468253135;6846.4522838172825;6570.5400621956005;6572.047053177167;6576.572522786004;6583.572067815577;6587.308332625197;6385.329540398191;6494.220693516808;6498.447631951337;6508.446782023581;6514.413702766774;6761.357671021246;6763.086983257197;6764.120664313607;6768.9661551691925;6770.4922130839395;4466.374707541012;4468.620167285687;4473.217186992199;4476.776161191862;4479.9328010079225;6463.192100987377;6545.5090868184125;6614.933850661432;6616.437602803623;6630.9668451657435;6387.169667943138;6422.454091402283;6423.068655044899;6423.775167869102;6426.871462570629;6409.198850143732;6412.262589802046;6416.069669897745;6417.133686952202;6423.454006409507;6081.483073938764;6259.061140828912;6265.592736472115;6275.52933529978;6312.968435157794;6403.455706265019;6403.4877209824035;6452.419282264619;6471.935280647322;6471.964485682268;6315.147455093504;6323.367663233824;6328.6202827830475;6331.96834015827;6334.366563343813 07:09:12 INFO - PROCESS | 21089 | |5;yui.html;793.1988691421664;853.978650533737;860.384824850232;867.757028032151;880.1814312689196;13454.327283635816;13553.52562660307;13597.38811753471;13638.38627261773;13639.795403068962;11102.167337449704;12805.871941280584;12808.359582020908;12830.230186188835;12876.67808304793;666.513445185014;762.6225018615793;780.7579650308394;781.4178437064367;783.5729527407576;829.618375547249;830.8462934357163;835.0730688935307;836;840.6385254340631;692.6848284030754;709.1702707831823;869.3827382558391;872.899616544096;874.1258741258741;846.5767116441779;854.692310768126;860.5783166248556;860.9612567434449;862.7713655881197;636.1666217255411;640.4460141977203;640.5004096804454;640.6092283706935;641.2657507154329;13072.803907941388;13129.34353282332;13239.139455935334;13244.735105297936;13263.73472530544;11674.88325116755;12143.210691305125;12763.808542871864;12771.48914043437;12881.484740610364;10088.69733907984;10107.545160467724;10187.490625468698;10380.480975951172;10397.116245119174;3588.6411358863907;3635.0912271932016;3670.137517683342;3674.2651469706166;3800.9619903801163;46220.306695399595;46352.07295854098;46774.76612616949;46880.29679554809;46958.947668401444;10008.299419040743;10028.398296102258;10068.093871551595;10155.847662285072;10175.185985121172;18856.90571547161;19350.709739353922;19382.8061719381;19400.320988765325;19415.708764368545;7810.101838288556;7836.373090152774;7852.685892564347;7913.248241417056;8003.599820008976;3500.68493835556;3993.8602148924647;4210.473690788652;4236.301010333322;4251.5748425157235;3053.435114503824;3068.7238148566735;3072.078376487045;3078.4766589679807;3079.16862447138;568.4116938968231;570.9600327977084;573.1746285349084;578.5863107877888;596.1981135372916;555.4112640600976;651.0104640945831;660.8546119853625;663.2174034639172;667.3193342790327;7394.112706475257;7476.102867655916;7536.321731044232;7817;7878.606069696492;572.321798668579;582.1006544888158;602.1013934772315;634.1027446163627;691.6438034412282;3654.6528079832906;3731.7574357666663;3786.8674596388996;3876.5154355705536;3883.10688541637;58686.70656646775;59169;59272.70363648154;59419.70290148608;59457.40542594605;51143;53207.73396132995;53253.73373133109;53269;53291.46708532942;46056;46179;46664.766676167084;47312.5268747315;47773.28340074832;7916.920830791619;7946.64240109208;8028.558429286211;8062.17719507336;8146.75559733209;34279;34727;35199.64800351964;35240.82379588085;35452.822735886155;40609.79695101506;40850.79574602108;41416.79291603523;44340.33489497595;44714;11652.359120248468;11755.294682319089;11884.702882428008;12157.878421215675;12249.203801752858;12067.637970860887;12202.398651996944;12325.322107284186;12506.37468126572;12506.562270320495;11283.774324513628;11289.661310160709;11881.465334060162;11985.22096063753;12262.20295680778;11620.186586938833;11969.461374238006;12314.568990085305;12371.628851134481;12395.256284622952;11009;11061.778764424505;11173.162012848907;11402.030827379765;11534.077273817906;9975.551100200653;10341.793164136825;10489.947550262199;10503.10944030082;10512.26414151002;8719.943633458683;9057.501837398742;9258.342954533056;9324.673636422693;9678.370905891095 07:09:12 INFO - PROCESS | 21089 | __end_tp_report 07:09:12 INFO - PROCESS | 21089 | __start_cc_report 07:09:12 INFO - PROCESS | 21089 | _x_x_mozilla_cycle_collect,957 07:09:12 INFO - PROCESS | 21089 | __end_cc_report 07:09:12 INFO - PROCESS | 21089 | __startTimestamp1452179352058__endTimestamp 07:09:12 INFO - PROCESS | 21089 | 07:09:12 INFO - PROCESS | 21089 | ------- Summary: start ------- 07:09:12 INFO - PROCESS | 21089 | Number of tests: 6 07:09:12 INFO - PROCESS | 21089 | 07:09:12 INFO - PROCESS | 21089 | [#0] dojo.html Cycles:165 Average:5219.85 Median:5441.29 stddev:571.43 (10.5%) stddev-sans-first:549.79 07:09:12 INFO - PROCESS | 21089 | Values: 3156.9 3189.8 3227.6 3230.4 3258.3 5040.2 5122.9 5178.8 5195.2 5246.8 5153.2 5172.5 5270.6 5284.1 5286.3 4599.0 4716.0 4772.6 4840.5 4879.7 4693.8 4807.7 4846.6 4886.7 4905.2 4674.3 4784.1 4786.5 4794.7 4822.9 4748.3 4755.5 4763.3 4766.6 4793.8 4678.8 4730.6 4749.6 4779.5 4783.8 5087.2 5205.2 5211.7 5221.7 5257.3 5580.2 5585.1 5590.3 5590.6 5607.1 5566.2 5614.8 5634.0 5647.2 5680.2 5213.8 5216.8 5217.7 5236.3 5383.9 5794.8 5803.0 5807.1 5825.2 5856.7 5490.5 5568.3 5585.3 5601.9 5644.2 5436.4 5564.8 5566.6 5671.3 5676.4 5612.1 5664.2 5677.4 5685.5 5719.9 5570.6 5598.0 5604.7 5604.7 5606.9 4255.1 4326.4 4336.7 4359.9 4405.4 3901.0 3905.0 3923.0 3942.7 3944.1 5193.8 5202.3 5203.2 5222.5 5252.5 5480.9 5533.0 5597.0 5624.2 5646.5 5093.5 5102.3 5117.7 5130.3 5131.1 4758.1 4771.5 4774.7 4775.9 4817.8 5660.8 5691.9 5723.7 5735.1 5736.8 5603.6 5625.0 5632.9 5692.7 5749.1 5831.8 5833.7 5838.0 5839.6 5850.1 5379.4 5516.7 5579.4 5585.9 5599.4 5590.4 5616.0 5636.7 5712.1 5774.6 5504.2 5542.9 5543.0 5547.1 5552.1 5422.9 5526.3 5535.8 5535.9 5546.6 5338.4 5371.6 5441.3 5458.2 5500.9 5539.0 5596.6 5596.9 5605.3 5656.8 5322.6 5423.8 5474.2 5483.6 5488.6 07:09:12 INFO - PROCESS | 21089 | 07:09:12 INFO - PROCESS | 21089 | [#1] ext.html Cycles:180 Average:47055.45 Median:18535.35 stddev:82665.68 (446.0%) stddev-sans-first:82823.78 07:09:12 INFO - PROCESS | 21089 | Values: 532.6 543.2 548.8 561.9 568.5 27498.2 28355.0 28368.6 36219.3 36737.4 38834.2 39256.8 39313.8 39387.2 39502.2 8401.2 8562.4 8575.8 8576.0 8587.3 7473.2 7627.9 9786.0 9936.0 9939.9 9633.7 9694.9 9704.5 9707.0 9708.5 7451.8 7612.5 9905.5 9962.9 10030.8 9840.1 10133.5 10137.5 10137.6 10148.6 35552.5 35690.1 35872.5 36004.6 36054.0 3183.8 3225.1 3357.0 3373.6 3567.5 27713.4 27963.0 28367.0 29107.4 30445.5 3940.1 3959.2 4009.6 4013.4 4098.5 250927.0 252984.0 253118.0 253431.0 254752.0 52090.2 52846.5 57250.4 58613.0 58657.7 66707.0 66851.7 67720.7 67754.3 67811.3 14755.9 15204.8 15254.8 15306.2 15316.5 11590.3 11676.8 11686.9 11697.9 11721.1 18645.0 18935.8 18983.2 19003.7 19275.2 7856.1 8085.2 8131.3 8149.4 8208.7 959.2 984.1 1015.8 1062.7 1078.1 28051.0 28109.7 28272.4 28543.6 28571.9 1061.4 1065.3 1082.3 1086.2 1149.0 14966.6 16089.6 16942.4 17032.2 17065.6 376602.0 381923.0 383148.0 383845.0 383948.0 54140.2 54427.0 54561.0 54689.7 54710.5 1336.2 1336.5 1347.8 1389.7 1392.0 29656.6 30203.8 30445.8 30500.4 30596.4 44482.6 45064.0 45108.0 45110.3 45223.0 291918.0 293274.0 295419.0 296127.0 296181.0 27676.7 28586.4 28628.3 28638.9 32045.5 36031.6 40952.1 41260.0 41270.6 41656.2 33099.7 34197.5 34418.8 34857.5 35205.0 31167.7 33713.7 34188.8 34436.8 34906.8 31472.7 31615.5 31635.8 31638.1 31746.0 25614.9 28455.0 29899.6 31287.4 31856.7 21076.8 21600.0 21602.4 21604.4 21641.6 07:09:12 INFO - PROCESS | 21089 | 07:09:12 INFO - PROCESS | 21089 | [#2] jquery.html Cycles:180 Average:28657.70 Median:17828.34 stddev:89735.19 (503.3%) stddev-sans-first:89961.76 07:09:12 INFO - PROCESS | 21089 | Values: 356.2 362.8 364.6 365.1 371.4 13728.5 13917.2 16273.4 16283.0 16683.0 14539.4 15117.1 15195.8 16317.8 16330.6 5348.2 5479.7 5479.9 5480.7 5482.1 4099.8 4207.5 5442.6 5477.2 5821.3 5928.9 5938.0 5964.7 5980.7 5988.1 5854.7 5919.3 6014.9 6018.3 6022.3 5305.6 5312.3 5313.7 5317.2 5325.3 19593.3 21453.8 21660.8 21682.6 21761.3 672.0 672.7 1077.6 1585.5 2416.7 12964.7 13253.0 13368.0 13436.7 13573.7 1807.5 1826.4 1833.6 1840.9 1862.9 60014.0 62435.1 63479.0 63553.7 64146.0 9651.1 9852.2 10063.5 10073.4 10113.5 13495.3 13502.9 13503.7 13511.4 13525.9 7641.2 7701.5 7706.8 7749.5 7852.2 7492.6 7524.8 7559.6 7585.8 7597.7 5975.4 5995.4 6070.5 6089.4 6155.3 1699.6 1744.6 1748.4 1786.1 1818.6 871.7 953.3 957.8 1046.4 1095.6 14855.7 17120.5 17798.6 17806.5 17997.9 954.2 966.8 1016.5 1035.0 1065.3 9683.0 9954.2 10274.0 10421.5 10462.2 535398.0 544031.0 546887.0 554599.0 570906.0 41235.0 41277.0 41296.4 79831.2 82731.0 1144.1 1151.2 1158.3 1165.8 1175.9 15285.5 15565.6 16015.9 16045.0 16313.2 35243.6 35300.5 36456.3 36639.6 37204.0 46848.5 48203.3 48366.0 49992.8 50763.0 8742.8 9095.2 9182.5 9183.4 9190.5 10703.4 12717.0 16908.3 17371.8 17394.0 13754.8 13768.2 13836.9 14055.4 14259.1 13916.3 14056.0 14263.5 14464.3 14510.9 11196.0 13574.4 13945.4 13971.9 14092.5 9031.1 9035.6 9049.5 9578.9 9803.6 3086.8 12669.5 14096.9 14540.2 15284.2 07:09:12 INFO - PROCESS | 21089 | 07:09:12 INFO - PROCESS | 21089 | [#3] mootools.html Cycles:180 Average:5240.70 Median:6233.56 stddev:2714.59 (43.5%) stddev-sans-first:2705.39 07:09:12 INFO - PROCESS | 21089 | Values: 1221.2 1443.6 1460.3 1559.5 1692.3 6606.8 7322.3 7438.4 7439.4 7458.8 7252.7 7434.7 7437.3 7450.3 7454.0 1950.5 1984.5 2192.0 2238.5 2281.9 2266.3 2272.8 2274.4 2276.3 2278.3 2140.5 2222.2 2222.3 2226.1 2226.9 2211.1 2242.7 2245.1 2245.4 2288.6 2274.5 2286.2 2298.4 2317.7 2319.3 7456.0 7536.5 7552.9 7555.5 7562.8 4517.6 4582.4 4606.1 4615.3 4617.1 3007.6 3050.9 3083.9 3101.6 3173.2 1024.7 1031.8 1033.3 1063.6 1103.6 10105.5 10202.2 10219.4 10232.8 10240.4 3967.7 4107.5 4110.8 4111.2 4198.6 8443.8 8538.5 8554.9 8577.4 8590.0 4541.2 4588.5 4621.1 4623.0 4625.1 4229.7 4233.7 4270.6 4272.8 4273.4 3199.7 3214.1 3397.2 3476.3 3535.6 1062.2 1078.8 1087.1 1088.6 1092.6 1009.8 1079.1 1083.0 1083.5 1085.6 6741.1 7055.3 7073.4 7076.6 7079.0 634.8 642.7 643.1 651.4 780.6 5626.3 5713.3 5724.5 5726.7 5733.1 8811.7 8830.6 9123.8 9157.8 9262.6 9104.6 9129.9 9152.7 9165.5 9166.3 6777.3 7038.5 7141.6 7219.0 7239.0 6896.2 6939.1 6961.2 6963.5 6984.1 7886.3 7919.7 8092.9 8276.7 8304.4 8277.8 8403.3 8559.4 8572.3 8592.7 6692.8 6693.8 6759.1 6928.4 6950.2 6386.1 6507.4 6775.6 6835.7 6884.1 6553.6 6652.4 6692.8 6768.9 6802.0 6389.9 6526.2 6527.6 6601.2 6649.2 6624.2 6629.4 6661.7 6667.3 6670.5 6066.7 6106.7 6110.2 6138.9 6142.6 6214.3 6252.9 6260.4 6276.8 6290.2 07:09:12 INFO - PROCESS | 21089 | 07:09:12 INFO - PROCESS | 21089 | [#4] prototype.html Cycles:180 Average:5301.47 Median:5969.84 stddev:1599.10 (26.8%) stddev-sans-first:1559.33 07:09:12 INFO - PROCESS | 21089 | Values: 324.1 325.3 328.3 332.3 338.1 5947.7 5955.8 5972.7 5998.5 6024.5 5698.1 5763.0 5817.3 5905.0 5926.9 4575.5 4577.3 4584.2 4587.4 4595.4 4409.2 4582.4 4583.4 4586.5 4587.9 4435.4 4457.8 4541.2 4549.1 4563.7 4559.6 4562.6 4569.6 4570.8 4575.6 3975.9 3981.0 3981.8 4016.6 4023.5 5521.4 5604.5 5608.2 5608.3 5622.4 5311.8 5320.2 5320.3 5328.6 5328.8 6271.4 6275.6 6275.8 6276.9 6280.8 4396.9 4401.5 4404.8 4445.3 4449.5 6306.6 6485.3 6492.8 6525.9 6548.0 4551.9 4553.6 4554.6 4557.4 4563.4 4610.4 4614.6 4616.1 4617.0 4621.7 5286.6 5288.6 5304.5 5306.2 5314.1 6195.9 6337.0 6397.2 6397.6 6416.6 1569.5 1577.8 1581.6 1582.2 1582.8 1056.5 1072.8 1074.3 1075.0 1089.8 5967.0 6000.5 6001.7 6005.9 6010.5 6503.4 6506.8 6510.9 6511.5 6512.6 5821.9 5874.6 5954.6 5981.7 5984.5 3512.8 3533.6 3538.2 3539.6 3544.1 6793.4 6794.1 6803.6 6804.2 6815.6 6556.0 6614.9 6698.0 6701.5 6729.8 6809.9 6814.8 6822.1 6825.3 6846.5 6570.5 6572.0 6576.6 6583.6 6587.3 6385.3 6494.2 6498.4 6508.4 6514.4 6761.4 6763.1 6764.1 6769.0 6770.5 4466.4 4468.6 4473.2 4476.8 4479.9 6463.2 6545.5 6614.9 6616.4 6631.0 6387.2 6422.5 6423.1 6423.8 6426.9 6409.2 6412.3 6416.1 6417.1 6423.5 6081.5 6259.1 6265.6 6275.5 6313.0 6403.5 6403.5 6452.4 6471.9 6472.0 6315.1 6323.4 6328.6 6332.0 6334.4 07:09:12 INFO - PROCESS | 21089 | 07:09:12 INFO - PROCESS | 21089 | [#5] yui.html Cycles:180 Average:13826.28 Median:4243.94 stddev:16025.15 (377.6%) stddev-sans-first:16040.21 07:09:12 INFO - PROCESS | 21089 | Values: 793.2 854.0 860.4 867.8 880.2 13454.3 13553.5 13597.4 13638.4 13639.8 11102.2 12805.9 12808.4 12830.2 12876.7 666.5 762.6 780.8 781.4 783.6 829.6 830.8 835.1 836.0 840.6 692.7 709.2 869.4 872.9 874.1 846.6 854.7 860.6 861.0 862.8 636.2 640.4 640.5 640.6 641.3 13072.8 13129.3 13239.1 13244.7 13263.7 11674.9 12143.2 12763.8 12771.5 12881.5 10088.7 10107.5 10187.5 10380.5 10397.1 3588.6 3635.1 3670.1 3674.3 3801.0 46220.3 46352.1 46774.8 46880.3 46958.9 10008.3 10028.4 10068.1 10155.8 10175.2 18856.9 19350.7 19382.8 19400.3 19415.7 7810.1 7836.4 7852.7 7913.2 8003.6 3500.7 3993.9 4210.5 4236.3 4251.6 3053.4 3068.7 3072.1 3078.5 3079.2 568.4 571.0 573.2 578.6 596.2 555.4 651.0 660.9 663.2 667.3 7394.1 7476.1 7536.3 7817.0 7878.6 572.3 582.1 602.1 634.1 691.6 3654.7 3731.8 3786.9 3876.5 3883.1 58686.7 59169.0 59272.7 59419.7 59457.4 51143.0 53207.7 53253.7 53269.0 53291.5 46056.0 46179.0 46664.8 47312.5 47773.3 7916.9 7946.6 8028.6 8062.2 8146.8 34279.0 34727.0 35199.6 35240.8 35452.8 40609.8 40850.8 41416.8 44340.3 44714.0 11652.4 11755.3 11884.7 12157.9 12249.2 12067.6 12202.4 12325.3 12506.4 12506.6 11283.8 11289.7 11881.5 11985.2 12262.2 11620.2 11969.5 12314.6 12371.6 12395.3 11009.0 11061.8 11173.2 11402.0 11534.1 9975.6 10341.8 10489.9 10503.1 10512.3 8719.9 9057.5 9258.3 9324.7 9678.4 07:09:12 INFO - PROCESS | 21089 | -------- Summary: end -------- 07:09:12 INFO - PROCESS | 21089 | 07:09:12 INFO - TEST-INFO | 21089: exit 0 07:09:12 INFO - TEST-OK | dromaeo_css | took 1113795ms 07:09:12 INFO - TEST-START | kraken 07:09:12 INFO - operating with platform_type : linux_ 07:09:12 INFO - Initialising browser for kraken test... 07:09:12 INFO - TEST-INFO | started process 21276 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkzJT3n/profile http://localhost:38831/getInfo.html) 07:09:17 INFO - PROCESS | 21276 | __metrics Screen width/height:1600/1200 07:09:17 INFO - PROCESS | 21276 | colorDepth:24 07:09:17 INFO - PROCESS | 21276 | Browser inner width/height: 1024/697 07:09:17 INFO - PROCESS | 21276 | __metrics 07:09:17 INFO - PROCESS | 21276 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:09:17 INFO - PROCESS | 21276 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:09:18 INFO - TEST-INFO | 21276: exit 0 07:09:18 INFO - Browser initialized. 07:09:18 INFO - Running cycle 1/1 for kraken test... 07:09:18 INFO - TEST-INFO | started process 21362 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkzJT3n/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:09:30 INFO - PROCESS | 21362 | RSS: Main: 150024192 07:09:30 INFO - PROCESS | 21362 | 07:09:32 INFO - PROCESS | 21362 | Cycle 1(1): loaded http://localhost:38831/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38831/tests/kraken/driver.html?testName=audio-beat-detection) 07:09:33 INFO - PROCESS | 21362 | RSS: Main: 185671680 07:09:33 INFO - PROCESS | 21362 | 07:09:35 INFO - PROCESS | 21362 | Cycle 1(1): loaded http://localhost:38831/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38831/tests/kraken/driver.html?testName=audio-dft) 07:09:36 INFO - PROCESS | 21362 | RSS: Main: 174256128 07:09:36 INFO - PROCESS | 21362 | 07:09:39 INFO - PROCESS | 21362 | Cycle 1(1): loaded http://localhost:38831/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38831/tests/kraken/driver.html?testName=audio-fft) 07:09:39 INFO - PROCESS | 21362 | RSS: Main: 160268288 07:09:39 INFO - PROCESS | 21362 | 07:09:41 INFO - PROCESS | 21362 | Cycle 1(1): loaded http://localhost:38831/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38831/tests/kraken/driver.html?testName=audio-oscillator) 07:09:42 INFO - PROCESS | 21362 | RSS: Main: 163196928 07:09:42 INFO - PROCESS | 21362 | 07:09:44 INFO - PROCESS | 21362 | Cycle 1(1): loaded http://localhost:38831/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38831/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:09:45 INFO - PROCESS | 21362 | RSS: Main: 165347328 07:09:45 INFO - PROCESS | 21362 | 07:09:48 INFO - PROCESS | 21362 | Cycle 1(1): loaded http://localhost:38831/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38831/tests/kraken/driver.html?testName=imaging-darkroom) 07:09:48 INFO - PROCESS | 21362 | RSS: Main: 165126144 07:09:48 INFO - PROCESS | 21362 | 07:09:52 INFO - PROCESS | 21362 | Cycle 1(1): loaded http://localhost:38831/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38831/tests/kraken/driver.html?testName=imaging-desaturate) 07:09:52 INFO - PROCESS | 21362 | RSS: Main: 165457920 07:09:52 INFO - PROCESS | 21362 | 07:09:55 INFO - PROCESS | 21362 | Cycle 1(1): loaded http://localhost:38831/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38831/tests/kraken/driver.html?testName=json-parse-financial) 07:09:56 INFO - PROCESS | 21362 | RSS: Main: 166842368 07:09:56 INFO - PROCESS | 21362 | 07:09:57 INFO - PROCESS | 21362 | Cycle 1(1): loaded http://localhost:38831/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38831/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:09:58 INFO - PROCESS | 21362 | RSS: Main: 179699712 07:09:58 INFO - PROCESS | 21362 | 07:09:59 INFO - PROCESS | 21362 | Cycle 1(1): loaded http://localhost:38831/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38831/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:10:00 INFO - PROCESS | 21362 | RSS: Main: 177614848 07:10:00 INFO - PROCESS | 21362 | 07:10:02 INFO - PROCESS | 21362 | Cycle 1(1): loaded http://localhost:38831/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38831/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:10:03 INFO - PROCESS | 21362 | RSS: Main: 188674048 07:10:03 INFO - PROCESS | 21362 | 07:10:05 INFO - PROCESS | 21362 | Cycle 1(1): loaded http://localhost:38831/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38831/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:10:06 INFO - PROCESS | 21362 | RSS: Main: 192598016 07:10:06 INFO - PROCESS | 21362 | 07:10:08 INFO - PROCESS | 21362 | Cycle 1(1): loaded http://localhost:38831/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38831/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:10:09 INFO - PROCESS | 21362 | RSS: Main: 191467520 07:10:09 INFO - PROCESS | 21362 | 07:10:11 INFO - PROCESS | 21362 | Cycle 1(1): loaded http://localhost:38831/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38831/tests/kraken/driver.html?testName=ai-astar) 07:10:11 INFO - PROCESS | 21362 | RSS: Main: 249901056 07:10:11 INFO - PROCESS | 21362 | 07:10:11 INFO - PROCESS | 21362 | __start_tp_report 07:10:11 INFO - PROCESS | 21362 | _x_x_mozilla_page_load 07:10:11 INFO - PROCESS | 21362 | _x_x_mozilla_page_load_details 07:10:11 INFO - PROCESS | 21362 | |i|pagename|runs| 07:10:11 INFO - PROCESS | 21362 | |0;ai-astar;110;110;103;109;110;110;99;110;110;109 07:10:11 INFO - PROCESS | 21362 | |1;audio-beat-detection;150;125;151;167;123;153;150;134;176;125 07:10:11 INFO - PROCESS | 21362 | |2;audio-dft;161;161;162;160;159;161;161;162;162;159 07:10:11 INFO - PROCESS | 21362 | |3;audio-fft;71;73;84;95;71;71;72;109;91;72 07:10:11 INFO - PROCESS | 21362 | |4;audio-oscillator;96;98;143;95;96;97;137;95;96;137 07:10:11 INFO - PROCESS | 21362 | |5;imaging-gaussian-blur;109;109;109;109;110;109;110;111;109;110 07:10:11 INFO - PROCESS | 21362 | |6;imaging-darkroom;148;145;146;146;146;146;145;146;147;146 07:10:11 INFO - PROCESS | 21362 | |7;imaging-desaturate;96;96;96;96;96;95;96;95;95;96 07:10:11 INFO - PROCESS | 21362 | |8;json-parse-financial;56;56;55;55;56;55;55;56;56;54 07:10:11 INFO - PROCESS | 21362 | |9;json-stringify-tinderbox;69;67;68;67;69;69;69;67;68;68 07:10:11 INFO - PROCESS | 21362 | |10;stanford-crypto-aes;84;84;93;86;87;87;87;85;87;94 07:10:11 INFO - PROCESS | 21362 | |11;stanford-crypto-ccm;120;117;126;118;131;121;123;119;132;124 07:10:11 INFO - PROCESS | 21362 | |12;stanford-crypto-pbkdf2;145;144;165;151;152;141;149;161;150;145 07:10:11 INFO - PROCESS | 21362 | |13;stanford-crypto-sha256-iterative;68;67;70;68;68;67;70;69;69;68 07:10:11 INFO - PROCESS | 21362 | __end_tp_report 07:10:11 INFO - PROCESS | 21362 | __start_cc_report 07:10:11 INFO - PROCESS | 21362 | _x_x_mozilla_cycle_collect,958 07:10:11 INFO - PROCESS | 21362 | __end_cc_report 07:10:11 INFO - PROCESS | 21362 | __startTimestamp1452179411307__endTimestamp 07:10:11 INFO - PROCESS | 21362 | 07:10:11 INFO - PROCESS | 21362 | ------- Summary: start ------- 07:10:11 INFO - PROCESS | 21362 | Number of tests: 14 07:10:11 INFO - PROCESS | 21362 | 07:10:11 INFO - PROCESS | 21362 | [#0] ai-astar Cycles:10 Average:108.00 Median:110.00 stddev:3.83 (3.5%) stddev-sans-first:3.99 07:10:11 INFO - PROCESS | 21362 | Values: 110.0 110.0 103.0 109.0 110.0 110.0 99.0 110.0 110.0 109.0 07:10:11 INFO - PROCESS | 21362 | 07:10:11 INFO - PROCESS | 21362 | [#1] audio-beat-detection Cycles:10 Average:145.40 Median:150.50 stddev:18.25 (12.1%) stddev-sans-first:19.28 07:10:11 INFO - PROCESS | 21362 | Values: 150.0 125.0 151.0 167.0 123.0 153.0 150.0 134.0 176.0 125.0 07:10:11 INFO - PROCESS | 21362 | 07:10:11 INFO - PROCESS | 21362 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:1.14 (0.7%) stddev-sans-first:1.20 07:10:11 INFO - PROCESS | 21362 | Values: 161.0 161.0 162.0 160.0 159.0 161.0 161.0 162.0 162.0 159.0 07:10:11 INFO - PROCESS | 21362 | 07:10:11 INFO - PROCESS | 21362 | [#3] audio-fft Cycles:10 Average:80.90 Median:72.50 stddev:13.40 (18.5%) stddev-sans-first:13.72 07:10:11 INFO - PROCESS | 21362 | Values: 71.0 73.0 84.0 95.0 71.0 71.0 72.0 109.0 91.0 72.0 07:10:11 INFO - PROCESS | 21362 | 07:10:11 INFO - PROCESS | 21362 | [#4] audio-oscillator Cycles:10 Average:109.00 Median:96.00 stddev:20.78 (21.7%) stddev-sans-first:21.51 07:10:11 INFO - PROCESS | 21362 | Values: 96.0 98.0 143.0 95.0 96.0 97.0 137.0 95.0 96.0 137.0 07:10:11 INFO - PROCESS | 21362 | 07:10:11 INFO - PROCESS | 21362 | [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:109.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 07:10:11 INFO - PROCESS | 21362 | Values: 109.0 109.0 109.0 109.0 110.0 109.0 110.0 111.0 109.0 110.0 07:10:11 INFO - PROCESS | 21362 | 07:10:11 INFO - PROCESS | 21362 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.88 (0.6%) stddev-sans-first:0.60 07:10:11 INFO - PROCESS | 21362 | Values: 148.0 145.0 146.0 146.0 146.0 146.0 145.0 146.0 147.0 146.0 07:10:11 INFO - PROCESS | 21362 | 07:10:11 INFO - PROCESS | 21362 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 07:10:11 INFO - PROCESS | 21362 | Values: 96.0 96.0 96.0 96.0 96.0 95.0 96.0 95.0 95.0 96.0 07:10:11 INFO - PROCESS | 21362 | 07:10:11 INFO - PROCESS | 21362 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:56.00 stddev:0.70 (1.2%) stddev-sans-first:0.71 07:10:11 INFO - PROCESS | 21362 | Values: 56.0 56.0 55.0 55.0 56.0 55.0 55.0 56.0 56.0 54.0 07:10:11 INFO - PROCESS | 21362 | 07:10:11 INFO - PROCESS | 21362 | [#9] json-stringify-tinderbox Cycles:10 Average:68.10 Median:68.50 stddev:0.88 (1.3%) stddev-sans-first:0.87 07:10:11 INFO - PROCESS | 21362 | Values: 69.0 67.0 68.0 67.0 69.0 69.0 69.0 67.0 68.0 68.0 07:10:11 INFO - PROCESS | 21362 | 07:10:11 INFO - PROCESS | 21362 | [#10] stanford-crypto-aes Cycles:10 Average:87.40 Median:87.00 stddev:3.44 (4.0%) stddev-sans-first:3.42 07:10:11 INFO - PROCESS | 21362 | Values: 84.0 84.0 93.0 86.0 87.0 87.0 87.0 85.0 87.0 94.0 07:10:11 INFO - PROCESS | 21362 | 07:10:11 INFO - PROCESS | 21362 | [#11] stanford-crypto-ccm Cycles:10 Average:123.10 Median:123.50 stddev:5.22 (4.2%) stddev-sans-first:5.41 07:10:11 INFO - PROCESS | 21362 | Values: 120.0 117.0 126.0 118.0 131.0 121.0 123.0 119.0 132.0 124.0 07:10:11 INFO - PROCESS | 21362 | 07:10:11 INFO - PROCESS | 21362 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.30 Median:150.50 stddev:7.59 (5.0%) stddev-sans-first:7.80 07:10:11 INFO - PROCESS | 21362 | Values: 145.0 144.0 165.0 151.0 152.0 141.0 149.0 161.0 150.0 145.0 07:10:11 INFO - PROCESS | 21362 | 07:10:11 INFO - PROCESS | 21362 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:68.50 stddev:1.07 (1.6%) stddev-sans-first:1.13 07:10:11 INFO - PROCESS | 21362 | Values: 68.0 67.0 70.0 68.0 68.0 67.0 70.0 69.0 69.0 68.0 07:10:11 INFO - PROCESS | 21362 | -------- Summary: end -------- 07:10:11 INFO - PROCESS | 21362 | 07:10:12 INFO - TEST-INFO | 21362: exit 0 07:10:12 INFO - TEST-OK | kraken | took 59364ms 07:10:12 INFO - TEST-START | v8_7 07:10:12 INFO - operating with platform_type : linux_ 07:10:12 INFO - Initialising browser for v8_7 test... 07:10:12 INFO - TEST-INFO | started process 21614 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpzJn9rr/profile http://localhost:38831/getInfo.html) 07:10:16 INFO - PROCESS | 21614 | __metrics Screen width/height:1600/1200 07:10:16 INFO - PROCESS | 21614 | colorDepth:24 07:10:16 INFO - PROCESS | 21614 | Browser inner width/height: 1024/697 07:10:16 INFO - PROCESS | 21614 | __metrics 07:10:16 INFO - PROCESS | 21614 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:10:16 INFO - PROCESS | 21614 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:10:17 INFO - TEST-INFO | 21614: exit 0 07:10:17 INFO - Browser initialized. 07:10:17 INFO - Running cycle 1/1 for v8_7 test... 07:10:17 INFO - TEST-INFO | started process 21696 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpzJn9rr/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:10:29 INFO - PROCESS | 21696 | RSS: Main: 150269952 07:10:29 INFO - PROCESS | 21696 | 07:10:50 INFO - PROCESS | 21696 | Cycle 1(1): loaded http://localhost:38831/tests/v8_7/run.html (next: http://localhost:38831/tests/v8_7/run.html) 07:10:51 INFO - PROCESS | 21696 | RSS: Main: 555208704 07:10:51 INFO - PROCESS | 21696 | 07:10:51 INFO - PROCESS | 21696 | __start_tp_report 07:10:51 INFO - PROCESS | 21696 | _x_x_mozilla_page_load 07:10:51 INFO - PROCESS | 21696 | _x_x_mozilla_page_load_details 07:10:51 INFO - PROCESS | 21696 | |i|pagename|runs| 07:10:51 INFO - PROCESS | 21696 | |0;Richards;166.63889351774705 07:10:51 INFO - PROCESS | 21696 | |1;DeltaBlue;191.0219675262655 07:10:51 INFO - PROCESS | 21696 | |2;Encrypt;280.0336040324839 07:10:51 INFO - PROCESS | 21696 | |3;Decrypt;5296.2962962962965 07:10:51 INFO - PROCESS | 21696 | |4;RayTrace;1980.1980198019803 07:10:51 INFO - PROCESS | 21696 | |5;Earley;777.1739130434783 07:10:51 INFO - PROCESS | 21696 | |6;Boyer;12407.407407407407 07:10:51 INFO - PROCESS | 21696 | |7;RegExp;25794.871794871793 07:10:51 INFO - PROCESS | 21696 | |8;Splay;561.7977528089888 07:10:51 INFO - PROCESS | 21696 | |9;NavierStokes;4859.223300970873 07:10:51 INFO - PROCESS | 21696 | __end_tp_report 07:10:51 INFO - PROCESS | 21696 | __startTimestamp1452179451193__endTimestamp 07:10:51 INFO - PROCESS | 21696 | 07:10:51 INFO - PROCESS | 21696 | ------- Summary: start ------- 07:10:51 INFO - PROCESS | 21696 | Number of tests: 10 07:10:51 INFO - PROCESS | 21696 | 07:10:51 INFO - PROCESS | 21696 | [#0] Richards Cycles:1 Average:166.64 Median:166.64 stddev:0.00 (0.0%) 07:10:51 INFO - PROCESS | 21696 | Values: 166.6 07:10:51 INFO - PROCESS | 21696 | 07:10:51 INFO - PROCESS | 21696 | [#1] DeltaBlue Cycles:1 Average:191.02 Median:191.02 stddev:0.00 (0.0%) 07:10:51 INFO - PROCESS | 21696 | Values: 191.0 07:10:51 INFO - PROCESS | 21696 | 07:10:51 INFO - PROCESS | 21696 | [#2] Encrypt Cycles:1 Average:280.03 Median:280.03 stddev:0.00 (0.0%) 07:10:51 INFO - PROCESS | 21696 | Values: 280.0 07:10:51 INFO - PROCESS | 21696 | 07:10:51 INFO - PROCESS | 21696 | [#3] Decrypt Cycles:1 Average:5296.30 Median:5296.30 stddev:0.00 (0.0%) 07:10:51 INFO - PROCESS | 21696 | Values: 5296.3 07:10:51 INFO - PROCESS | 21696 | 07:10:51 INFO - PROCESS | 21696 | [#4] RayTrace Cycles:1 Average:1980.20 Median:1980.20 stddev:0.00 (0.0%) 07:10:51 INFO - PROCESS | 21696 | Values: 1980.2 07:10:51 INFO - PROCESS | 21696 | 07:10:51 INFO - PROCESS | 21696 | [#5] Earley Cycles:1 Average:777.17 Median:777.17 stddev:0.00 (0.0%) 07:10:51 INFO - PROCESS | 21696 | Values: 777.2 07:10:51 INFO - PROCESS | 21696 | 07:10:51 INFO - PROCESS | 21696 | [#6] Boyer Cycles:1 Average:12407.41 Median:12407.41 stddev:0.00 (0.0%) 07:10:51 INFO - PROCESS | 21696 | Values: 12407.4 07:10:51 INFO - PROCESS | 21696 | 07:10:51 INFO - PROCESS | 21696 | [#7] RegExp Cycles:1 Average:25794.87 Median:25794.87 stddev:0.00 (0.0%) 07:10:51 INFO - PROCESS | 21696 | Values: 25794.9 07:10:51 INFO - PROCESS | 21696 | 07:10:51 INFO - PROCESS | 21696 | [#8] Splay Cycles:1 Average:561.80 Median:561.80 stddev:0.00 (0.0%) 07:10:51 INFO - PROCESS | 21696 | Values: 561.8 07:10:51 INFO - PROCESS | 21696 | 07:10:51 INFO - PROCESS | 21696 | [#9] NavierStokes Cycles:1 Average:4859.22 Median:4859.22 stddev:0.00 (0.0%) 07:10:51 INFO - PROCESS | 21696 | Values: 4859.2 07:10:51 INFO - PROCESS | 21696 | -------- Summary: end -------- 07:10:51 INFO - PROCESS | 21696 | 07:10:52 INFO - TEST-INFO | 21696: exit 0 07:10:52 INFO - TEST-OK | v8_7 | took 39900ms 07:10:52 INFO - SUITE-END | took 1213s 07:10:52 INFO - Completed test suite (00:20:13) 07:10:52 INFO - Working with test: dromaeo_css 07:10:52 INFO - Generating results file: dromaeo_css 07:10:52 INFO - Working with test: kraken 07:10:52 INFO - Generating results file: kraken 07:10:52 INFO - javascript benchmark 07:10:52 INFO - Working with test: v8_7 07:10:52 INFO - Generating results file: v8_7 07:10:52 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:10:53 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 07:10:53 INFO - process_Request line: dromaeo_css 6893.57 graph.html#tests=[[72,1,35]] 07:10:53 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:10:53 INFO - process_Request line: kraken 1508.10 graph.html#tests=[[232,1,35]] 07:10:53 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:10:53 INFO - process_Request line: v8_7 19913.33 graph.html#tests=[[230,1,35]] 07:10:53 INFO - RETURN: dromaeo_css: 6893.57 07:10:53 INFO - RETURN: kraken: 1508.10 07:10:53 INFO - RETURN: v8_7: 19913.33 07:10:53 INFO - javascript benchmark 07:10:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3156.8579413926373, 3189.8405079746008, 3227.596550431196, 3230.4185246655607, 3258.348330333933, 5040.1935690289565, 5122.92315615266, 5178.818741344054, 5195.194744814555, 5246.842594722155, 5153.201253805666, 5172.456892026339, 5270.578353731702, 5284.101702710539, 5286.259923610688, 4599.0, 4716.0, 4772.594329481998, 4840.467548569654, 4879.731614761205, 4693.7653117344, 4807.687500312486, 4846.61227101831, 4886.706797592138, 4905.215165573509, 4674.252119660855, 4784.091022705692, 4786.473487916326, 4794.736289504076, 4822.879428014293, 4748.311494833264, 4755.476897541268, 4763.261694437368, 4766.618670506386, 4793.784279707386, 4678.766061696935, 4730.645201609858, 4749.596284315838, 4779.545943135397, 4783.832565860213, 5087.211482220262, 5205.219217117425, 5211.7133557654315, 5221.73891305437, 5257.316548848664, 5580.218769372291, 5585.05054140793, 5590.2732644756325, 5590.580706446992, 5607.130894711327, 5566.192902029183, 5614.775408983635, 5633.95668020617, 5647.181158732002, 5680.204771332017, 5213.7914483421, 5216.843494695166, 5217.713025783581, 5236.319278493847, 5383.892322153535, 5794.768209271666, 5803.0, 5807.0998995155815, 5825.242718446575, 5856.677882716406, 5490.490115218347, 5568.331800184003, 5585.329760428694, 5601.915971260434, 5644.153376993484, 5436.40199578054, 5564.805231816867, 5566.582506311962, 5671.347795003545, 5676.403977582377, 5612.130119831432, 5664.20701101846, 5677.403872593318, 5685.516731077904, 5719.942800571941, 5570.554355651539, 5598.0, 5604.663720176803, 5604.6917419541505, 5606.85982850432, 4255.127698821796, 4326.372675961968, 4336.696431249846, 4359.934600980988, 4405.405270288534, 3900.9804950975063, 3904.9804750976064, 3923.0388554804254, 3942.664873485786, 3944.073142811437, 5193.766280517386, 5202.297689811902, 5203.19350500673, 5222.451642577551, 5252.527272545489, 5480.862978425571, 5533.03171944908, 5596.972015139898, 5624.156376543551, 5646.548276137899, 5093.516115968977, 5102.260172275073, 5117.692938423706, 5130.281760553526, 5131.102057139986, 4758.072175925661, 4771.498992605796, 4774.689645173053, 4775.904481910342, 4817.78319975602, 5660.773569057192, 5691.857703557362, 5723.656580605094, 5735.082386818089, 5736.799212027559, 5603.55171586264, 5625.0, 5632.943670563406, 5692.686902220417, 5749.108888122348, 5831.766729330949, 5833.67914764692, 5838.0, 5839.620424672383, 5850.12248162779, 5379.381371142369, 5516.696581688046, 5579.386267510652, 5585.916211256916, 5599.384067752625, 5590.440955904377, 5615.971920140373, 5636.661800291996, 5712.0860662293835, 5774.56690748204, 5504.22940788282, 5542.861428464159, 5543.029969755357, 5547.084731019498, 5552.111662134039, 5422.891542169214, 5526.336839579276, 5535.750891209825, 5535.944640553543, 5546.639468434539, 5338.4394638563945, 5371.5971302153275, 5441.29263195782, 5458.208559758892, 5500.9174862377895, 5538.972305138448, 5596.636218645775, 5596.944030559643, 5605.271314729059, 5656.773729050957, 5322.627416080837, 5423.810166644149, 5474.233607295061, 5483.588730845282, 5488.615796894179], "unit": "score", "name": "dojo.html", "value": 5183.836618746174}, {"lowerIsBetter": false, "replicates": [532.6431291035004, 543.2313276713451, 548.780487804878, 561.8874628236092, 568.5224411494344, 27498.175054748364, 28355.0, 28368.57447138292, 36219.27561448769, 36737.448938265945, 38834.22331553367, 39256.80371598145, 39313.80343098281, 39387.212255754865, 39502.20995580087, 8401.24388805009, 8562.443441176334, 8575.828483430327, 8575.970883493957, 8587.31301495882, 7473.215312392175, 7627.923720762777, 9785.951070244639, 9936.0, 9939.850902236472, 9633.66282180124, 9694.903050969506, 9704.514774261293, 9707.0, 9708.514574271294, 7451.813704657373, 7612.467127301091, 9905.504724763769, 9962.850557241647, 10030.799384012278, 9840.06519380665, 10133.493325333704, 10137.543810528545, 10137.594496220143, 10148.594056237742, 35552.466712999325, 35690.10774730652, 35872.461913071325, 36004.63995360039, 36054.0, 3183.761217908666, 3225.1130938991732, 3357.0432426758503, 3373.645767194458, 3567.5362202913457, 27713.445731085467, 27963.021294254806, 28367.0, 29107.417851643062, 30445.543316850264, 3940.0804383189993, 3959.227950549644, 4009.599040095967, 4013.4180543821276, 4098.4876890388705, 250927.0, 252984.0, 253118.0, 253431.0, 254752.0, 52090.21864672033, 52846.47153528415, 57250.427495725344, 58613.0, 58657.70671146617, 66707.0, 66851.66574167098, 67720.6613966927, 67754.32245677579, 67811.3218867805, 14755.926220368829, 15204.847951520564, 15254.771178432333, 15306.234688265542, 15316.463923762614, 11590.304581724955, 11676.824847627122, 11686.883131168579, 11697.941510292565, 11721.062315014779, 18645.0, 18935.81064189368, 18983.24067037303, 19003.714944275845, 19275.22899084021, 7856.135825059353, 8085.231902969209, 8131.2681858633005, 8149.429539932266, 8208.712695055645, 959.1894848852709, 984.1192133041031, 1015.7968406318618, 1062.7130674717782, 1078.0728573426848, 28051.0, 28109.71890281112, 28272.43455130886, 28543.57184642232, 28571.857140714164, 1061.400308825511, 1065.2862582070031, 1082.3235477826358, 1086.1799341497276, 1149.0, 14966.551003469913, 16089.597760056093, 16942.40701575439, 17032.233549490054, 17065.573360666083, 376602.0, 381923.0, 383148.0, 383845.0, 383948.0, 54140.187897181575, 54427.0, 54561.0, 54689.72655136699, 54710.45289547133, 1336.1782503760116, 1336.5188532128425, 1347.8382594088575, 1389.7498450279047, 1392.0464481829777, 29656.555151673172, 30203.848980754956, 30445.847770761004, 30500.389992200475, 30596.388072238875, 44482.55517444914, 45064.0, 45108.0, 45110.32334515051, 45223.0, 291918.0, 293274.0, 295419.0, 296127.0, 296181.0, 27676.72323276822, 28586.42827143487, 28628.284292892844, 28638.856805715837, 32045.51931721073, 36031.63968360388, 40952.13335066636, 41260.0, 41270.58729412667, 41656.1668766629, 33099.66900330966, 34197.48703769396, 34418.82790586031, 34857.47713784245, 35205.0, 31167.68832311648, 33713.66286337105, 34188.82905585556, 34436.82781586076, 34906.825465872505, 31472.68527314789, 31615.525767113053, 31635.84182079075, 31638.050858474282, 31746.0, 25614.87192564025, 28455.0, 29899.55150672698, 31287.374252515277, 31856.68143318537, 21076.789232107483, 21600.0, 21602.351929442142, 21604.35186944394, 21641.567168656853], "unit": "score", "name": "ext.html", "value": 18261.360382392766}, {"lowerIsBetter": false, "replicates": [356.20210727969356, 362.84397708985136, 364.59894116471867, 365.13463092470846, 371.3964807188319, 13728.450861965533, 13917.23455209963, 16273.430429934955, 16283.0, 16683.0, 14539.418423263083, 15117.092974421543, 15195.772063419057, 16317.755233671505, 16330.591735206626, 5348.171033489796, 5479.671219726829, 5479.945200548003, 5480.671159730409, 5482.068048431756, 4099.795010249491, 4207.537170911197, 5442.564594832424, 5477.233187353754, 5821.330546987108, 5928.88142237155, 5938.0499120140785, 5964.671943043131, 5980.700964951757, 5988.071848863433, 5854.707264636772, 5919.319278283009, 6014.939850601481, 6018.337982821908, 6022.337542870281, 5305.602079844027, 5312.2828418163435, 5313.734313284359, 5317.229001794718, 5325.281087053237, 19593.314234001886, 21453.78546214549, 21660.783392166035, 21682.56634867294, 21761.34715958524, 671.9731210751564, 672.6872004517874, 1077.5959015369237, 1585.4847174668164, 2416.673749043874, 12964.675883102904, 13253.006024548198, 13368.0, 13436.664083397896, 13573.728525429535, 1807.548112971757, 1826.3516451659602, 1833.578276996285, 1840.8527317814542, 1862.850971922243, 60014.0, 62435.06347404747, 63479.0, 63553.68223158901, 64146.0, 9651.131398174199, 9852.16256618181, 10063.5471403787, 10073.395596264247, 10113.494325283706, 13495.325233738275, 13502.864971350356, 13503.662408439868, 13511.391987360592, 13525.864741352658, 7641.159472458025, 7701.537907725555, 7706.807329816687, 7749.535027898231, 7852.175521570267, 7492.587907665022, 7524.849503010018, 7559.584222867685, 7585.772426827204, 7597.658105385271, 5975.43233392827, 5995.430434108753, 6070.514358851281, 6089.360617135226, 6155.292141403706, 1699.6090899093278, 1744.5725797179773, 1748.414281215807, 1786.0712429536568, 1818.5817262029807, 871.6639406390807, 953.3421938862163, 957.8084383123264, 1046.3617193511952, 1095.611058074388, 14855.70288594222, 17120.486385408458, 17798.644027119386, 17806.496681802255, 17997.910010449865, 954.236610711428, 966.8114717629994, 1016.4714348538866, 1035.0, 1065.2543219746208, 9682.951585242028, 9954.208242516272, 10274.0, 10421.53103110362, 10462.163026957825, 535398.0, 544031.0, 546887.0, 554599.0, 570906.0, 41235.0, 41277.0, 41296.38055429171, 79831.20168798354, 82731.0, 1144.119028348184, 1151.2171723228118, 1158.29922896648, 1165.8367828504017, 1175.8588969323737, 15285.541433757006, 15565.610859728144, 16015.919920400323, 16045.0, 16313.184340783151, 35243.647563524035, 35300.47049294314, 36456.27087458183, 36639.63360366362, 37204.0, 46848.531514684415, 48203.276950845066, 48366.0, 49992.750036249585, 50763.0, 8742.781430464289, 9095.226905712823, 9182.494962776844, 9183.403078799856, 9190.540472976458, 10703.411312377893, 12717.0, 16908.32366705367, 17371.82628173702, 17394.0, 13754.793678094637, 13768.173909565458, 13836.930815345859, 14055.437782488585, 14259.07316024455, 13916.304184790517, 14056.0, 14263.500777472738, 14464.276786160439, 14510.927445362706, 11196.0, 13574.389152488358, 13945.39627942759, 13971.860281397056, 14092.506762263272, 9031.142041506046, 9035.638574456949, 9049.547522623974, 9578.9042109578, 9803.558839852367, 3086.830224337683, 12669.493220271455, 14096.859031409555, 14540.200288984208, 15284.235788210768], "unit": "score", "name": "jquery.html", "value": 8825.966065846695}, {"lowerIsBetter": false, "replicates": [1221.1635030004443, 1443.6246575890268, 1460.335547325967, 1559.4775750123708, 1692.3230707716905, 6606.768763093292, 7322.304381083795, 7438.404927605799, 7439.404847612192, 7458.7762367128935, 7252.673629686664, 7434.665440055197, 7437.330640242377, 7450.329470347668, 7454.0, 1950.473372189515, 1984.464194667439, 2192.0464597899886, 2238.462768935452, 2281.863088214712, 2266.3087758233733, 2272.7727227277305, 2274.385915802732, 2276.3398614401804, 2278.3392816083315, 2140.4862832920066, 2222.188901051121, 2222.2666520048347, 2226.0539270809923, 2226.866388016716, 2211.1266049910278, 2242.7196600424945, 2245.146844199202, 2245.38251980705, 2288.599495088361, 2274.5223503064376, 2286.16554957441, 2298.4139044543704, 2317.6755254264417, 2319.3042087373888, 7456.0, 7536.4724469287175, 7552.924470755277, 7555.508891922007, 7562.810929726746, 4517.570830771071, 4582.358469814229, 4606.078784243131, 4615.330777037311, 4617.12274667812, 3007.5639032340187, 3050.923726906845, 3083.938321233585, 3101.550275210082, 3173.2384227785396, 1024.7489365105523, 1031.7730099378125, 1033.2560556399455, 1063.6489958313816, 1103.5585765693706, 10105.494725263707, 10202.183825293958, 10219.386836789741, 10232.795344093076, 10240.436775977318, 3967.662748666338, 4107.486564179478, 4110.835566577303, 4111.177764447122, 4198.6431153352305, 8443.83112337762, 8538.487690738575, 8554.871676924851, 8577.399582029322, 8590.012148602866, 4541.205289074399, 4588.472325682589, 4621.075784843045, 4623.029163875556, 4625.098105869323, 4229.703920725519, 4233.724807887477, 4270.572942705767, 4272.807723652443, 4273.423087883096, 3199.7361042388593, 3214.148250713563, 3397.21863971288, 3476.322117187124, 3535.5580552430947, 1062.2404980439023, 1078.8489611454402, 1087.0542627913608, 1088.6081010836092, 1092.5575142067476, 1009.848522721583, 1079.0989523747758, 1082.99458502707, 1083.5394957143183, 1085.6091806949491, 6741.1236539249585, 7055.2944705529035, 7073.363397294268, 7076.610786406797, 7079.0, 634.80321100459, 642.6658137768334, 643.1381948189448, 651.4397618048474, 780.6018930345565, 5626.2967129108865, 5713.314402271671, 5724.542036637059, 5726.685032323262, 5733.140028995601, 8811.691590794291, 8830.55847207637, 9123.81752364949, 9157.771055723528, 9262.583183756748, 9104.590293436811, 9129.863052054225, 9152.679656212134, 9165.450072995642, 9166.266698664223, 6777.288384719632, 7038.472114591426, 7141.57150570957, 7218.963905180441, 7238.98654188414, 6896.241413444617, 6939.132608423947, 6961.199462061725, 6963.512554121163, 6984.126984126984, 7886.329661978796, 7919.722809701633, 8092.919070809452, 8276.668933242603, 8304.377171712267, 8277.751667449986, 8403.327733781405, 8559.443636163629, 8572.314214862921, 8592.65629374818, 6692.83267918306, 6693.765718199839, 6759.121314229119, 6928.445724342141, 6950.235474097946, 6386.074019267087, 6507.381798729113, 6775.593464392152, 6835.726570937107, 6884.105066341343, 6553.574017688835, 6652.40128388428, 6692.765753198614, 6768.932310676831, 6802.0477133202385, 6389.87220255583, 6526.24948130971, 6527.5757075789925, 6601.240857301472, 6649.202095748541, 6624.171978502687, 6629.370209830058, 6661.700223489857, 6667.333266673294, 6670.466362690876, 6066.666333351532, 6106.6946652668075, 6110.205673262625, 6138.907916381168, 6142.6314421134875, 6214.25428948529, 6252.874942501034, 6260.40526150015, 6276.811695649138, 6290.150829637941], "unit": "score", "name": "mootools.html", "value": 4272.445092563741}, {"lowerIsBetter": false, "replicates": [324.07476654152396, 325.31196519361555, 328.32365327425504, 332.297191440104, 338.1090825674347, 5947.672877991708, 5955.761769529219, 5972.671503067335, 5998.460138587527, 6024.54815888809, 5698.116791897252, 5763.049096899017, 5817.301923769153, 5905.025670764318, 5926.911096333559, 4575.450945886481, 4577.29051996941, 4584.197765391052, 4587.42657167854, 4595.425571803525, 4409.206342858284, 4582.381378513908, 4583.404157459526, 4586.495485496593, 4587.908241835161, 4435.379046933432, 4457.754823484724, 4541.205289074415, 4549.11292298002, 4563.680542362036, 4559.635229181674, 4562.634989200856, 4569.588737013652, 4570.79431425585, 4575.58819706228, 3975.940360894589, 3980.9848488635503, 3981.820818063165, 4016.598340165989, 4023.517177938637, 5521.420250873641, 5604.523615492688, 5608.186812912146, 5608.270924779793, 5622.381538030813, 5311.760970756325, 5320.17537281722, 5320.255164277004, 5328.600354973354, 5328.786848526054, 6271.372862713738, 6275.592086514362, 6275.811725648238, 6276.905846412307, 6280.78017269398, 4396.89007774805, 4401.471823381215, 4404.779761011937, 4445.288753799409, 4449.488308844459, 6306.590071645374, 6485.319041500669, 6492.837679058014, 6525.869482610368, 6547.9672601636685, 4551.908961820745, 4553.635709143261, 4554.63562914966, 4557.430321209848, 4563.361129441881, 4610.423697037871, 4614.630829533697, 4616.146012987608, 4616.976915115403, 4621.722696638145, 5286.60350473716, 5288.603354748409, 5304.549113325334, 5306.204069389545, 5314.0700377433795, 6195.938040619536, 6336.968315158395, 6397.200349956255, 6397.648129352837, 6416.550841441148, 1569.50560573419, 1577.8027746531684, 1581.6045988502874, 1582.1772678207267, 1582.8258891521923, 1056.455925198508, 1072.790805792863, 1074.3446497636435, 1075.0, 1089.7929393415225, 5967.0, 6000.519958403317, 6001.669908155093, 6005.939940600538, 6010.549208809357, 6503.382178693017, 6506.772262970773, 6510.934890651033, 6511.544191906521, 6512.6092434454085, 5821.912671309934, 5874.647521148745, 5954.583179177416, 5981.730822112929, 5984.521238300926, 3512.8243587820507, 3533.646635336446, 3538.203904121552, 3539.592946811098, 3544.0608238816735, 6793.422559082534, 6794.0827988221945, 6803.557768745016, 6804.21751498584, 6815.625140617214, 6555.967220163869, 6614.86770264592, 6698.0, 6701.530892837454, 6729.798106056826, 6809.863802723918, 6814.761483348059, 6822.147231596051, 6825.317468253135, 6846.4522838172825, 6570.5400621956005, 6572.047053177167, 6576.572522786004, 6583.572067815577, 6587.308332625197, 6385.329540398191, 6494.220693516808, 6498.447631951337, 6508.446782023581, 6514.413702766774, 6761.357671021246, 6763.086983257197, 6764.120664313607, 6768.9661551691925, 6770.4922130839395, 4466.374707541012, 4468.620167285687, 4473.217186992199, 4476.776161191862, 4479.9328010079225, 6463.192100987377, 6545.5090868184125, 6614.933850661432, 6616.437602803623, 6630.9668451657435, 6387.169667943138, 6422.454091402283, 6423.068655044899, 6423.775167869102, 6426.871462570629, 6409.198850143732, 6412.262589802046, 6416.069669897745, 6417.133686952202, 6423.454006409507, 6081.483073938764, 6259.061140828912, 6265.592736472115, 6275.52933529978, 6312.968435157794, 6403.455706265019, 6403.4877209824035, 6452.419282264619, 6471.935280647322, 6471.964485682268, 6315.147455093504, 6323.367663233824, 6328.6202827830475, 6331.96834015827, 6334.366563343813], "unit": "score", "name": "prototype.html", "value": 4778.10332471281}, {"lowerIsBetter": false, "replicates": [793.1988691421664, 853.978650533737, 860.384824850232, 867.757028032151, 880.1814312689196, 13454.327283635816, 13553.52562660307, 13597.38811753471, 13638.38627261773, 13639.795403068962, 11102.167337449704, 12805.871941280584, 12808.359582020908, 12830.230186188835, 12876.67808304793, 666.513445185014, 762.6225018615793, 780.7579650308394, 781.4178437064367, 783.5729527407576, 829.618375547249, 830.8462934357163, 835.0730688935307, 836.0, 840.6385254340631, 692.6848284030754, 709.1702707831823, 869.3827382558391, 872.899616544096, 874.1258741258741, 846.5767116441779, 854.692310768126, 860.5783166248556, 860.9612567434449, 862.7713655881197, 636.1666217255411, 640.4460141977203, 640.5004096804454, 640.6092283706935, 641.2657507154329, 13072.803907941388, 13129.34353282332, 13239.139455935334, 13244.735105297936, 13263.73472530544, 11674.88325116755, 12143.210691305125, 12763.808542871864, 12771.48914043437, 12881.484740610364, 10088.69733907984, 10107.545160467724, 10187.490625468698, 10380.480975951172, 10397.116245119174, 3588.6411358863907, 3635.0912271932016, 3670.137517683342, 3674.2651469706166, 3800.9619903801163, 46220.306695399595, 46352.07295854098, 46774.76612616949, 46880.29679554809, 46958.947668401444, 10008.299419040743, 10028.398296102258, 10068.093871551595, 10155.847662285072, 10175.185985121172, 18856.90571547161, 19350.709739353922, 19382.8061719381, 19400.320988765325, 19415.708764368545, 7810.101838288556, 7836.373090152774, 7852.685892564347, 7913.248241417056, 8003.599820008976, 3500.68493835556, 3993.8602148924647, 4210.473690788652, 4236.301010333322, 4251.5748425157235, 3053.435114503824, 3068.7238148566735, 3072.078376487045, 3078.4766589679807, 3079.16862447138, 568.4116938968231, 570.9600327977084, 573.1746285349084, 578.5863107877888, 596.1981135372916, 555.4112640600976, 651.0104640945831, 660.8546119853625, 663.2174034639172, 667.3193342790327, 7394.112706475257, 7476.102867655916, 7536.321731044232, 7817.0, 7878.606069696492, 572.321798668579, 582.1006544888158, 602.1013934772315, 634.1027446163627, 691.6438034412282, 3654.6528079832906, 3731.7574357666663, 3786.8674596388996, 3876.5154355705536, 3883.10688541637, 58686.70656646775, 59169.0, 59272.70363648154, 59419.70290148608, 59457.40542594605, 51143.0, 53207.73396132995, 53253.73373133109, 53269.0, 53291.46708532942, 46056.0, 46179.0, 46664.766676167084, 47312.5268747315, 47773.28340074832, 7916.920830791619, 7946.64240109208, 8028.558429286211, 8062.17719507336, 8146.75559733209, 34279.0, 34727.0, 35199.64800351964, 35240.82379588085, 35452.822735886155, 40609.79695101506, 40850.79574602108, 41416.79291603523, 44340.33489497595, 44714.0, 11652.359120248468, 11755.294682319089, 11884.702882428008, 12157.878421215675, 12249.203801752858, 12067.637970860887, 12202.398651996944, 12325.322107284186, 12506.37468126572, 12506.562270320495, 11283.774324513628, 11289.661310160709, 11881.465334060162, 11985.22096063753, 12262.20295680778, 11620.186586938833, 11969.461374238006, 12314.568990085305, 12371.628851134481, 12395.256284622952, 11009.0, 11061.778764424505, 11173.162012848907, 11402.030827379765, 11534.077273817906, 9975.551100200653, 10341.793164136825, 10489.947550262199, 10503.10944030082, 10512.26414151002, 8719.943633458683, 9057.501837398742, 9258.342954533056, 9324.673636422693, 9678.370905891095], "unit": "score", "name": "yui.html", "value": 6291.3939887683955}], "name": "dromaeo_css", "value": 6893.5720783159895}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 110.0, 103.0, 109.0, 110.0, 110.0, 99.0, 110.0, 110.0, 109.0], "unit": "score", "name": "ai-astar", "value": 108.0}, {"lowerIsBetter": true, "replicates": [150.0, 125.0, 151.0, 167.0, 123.0, 153.0, 150.0, 134.0, 176.0, 125.0], "unit": "score", "name": "audio-beat-detection", "value": 145.4}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 162.0, 160.0, 159.0, 161.0, 161.0, 162.0, 162.0, 159.0], "unit": "score", "name": "audio-dft", "value": 160.8}, {"lowerIsBetter": true, "replicates": [71.0, 73.0, 84.0, 95.0, 71.0, 71.0, 72.0, 109.0, 91.0, 72.0], "unit": "score", "name": "audio-fft", "value": 80.9}, {"lowerIsBetter": true, "replicates": [96.0, 98.0, 143.0, 95.0, 96.0, 97.0, 137.0, 95.0, 96.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 109.0}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 110.0, 111.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.5}, {"lowerIsBetter": true, "replicates": [148.0, 145.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.1}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [56.0, 56.0, 55.0, 55.0, 56.0, 55.0, 55.0, 56.0, 56.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 55.4}, {"lowerIsBetter": true, "replicates": [69.0, 67.0, 68.0, 67.0, 69.0, 69.0, 69.0, 67.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.1}, {"lowerIsBetter": true, "replicates": [84.0, 84.0, 93.0, 86.0, 87.0, 87.0, 87.0, 85.0, 87.0, 94.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.4}, {"lowerIsBetter": true, "replicates": [120.0, 117.0, 126.0, 118.0, 131.0, 121.0, 123.0, 119.0, 132.0, 124.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.1}, {"lowerIsBetter": true, "replicates": [145.0, 144.0, 165.0, 151.0, 152.0, 141.0, 149.0, 161.0, 150.0, 145.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 150.3}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 70.0, 68.0, 68.0, 67.0, 70.0, 69.0, 69.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.4}], "name": "kraken", "value": 1508.1000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.63889351774705], "unit": "score", "name": "Richards", "value": 211.84730199999996}, {"lowerIsBetter": false, "replicates": [191.0219675262655], "unit": "score", "name": "DeltaBlue", "value": 346.12773000000004}, {"lowerIsBetter": false, "replicates": [280.0336040324839], "unit": "score", "name": "Encrypt", "value": 950.5323509999997}, {"lowerIsBetter": false, "replicates": [5296.2962962962965], "unit": "score", "name": "Decrypt", "value": 50.25795104895107}, {"lowerIsBetter": false, "replicates": [1980.1980198019803], "unit": "score", "name": "RayTrace", "value": 373.6944450000001}, {"lowerIsBetter": false, "replicates": [777.1739130434783], "unit": "score", "name": "Earley", "value": 857.5467972027974}, {"lowerIsBetter": false, "replicates": [12407.407407407407], "unit": "score", "name": "Boyer", "value": 53.71492835820899}, {"lowerIsBetter": false, "replicates": [25794.871794871793], "unit": "score", "name": "RegExp", "value": 35.31651590457257}, {"lowerIsBetter": false, "replicates": [561.7977528089888], "unit": "score", "name": "Splay", "value": 145.05398000000002}, {"lowerIsBetter": false, "replicates": [4859.223300970873], "unit": "score", "name": "NavierStokes", "value": 305.39860139860156}], "name": "v8_7", "value": 19913.330490960216}]} 07:10:53 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,35]]", "result": "19913.33"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1508.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6893.57"}}} 07:10:53 INFO - Return code: 0 07:10:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 07:10:53 INFO - # TBPL SUCCESS # 07:10:53 INFO - Running post-action listener: _resource_record_post_action 07:10:53 INFO - Running post-run listener: _resource_record_post_run 07:10:54 INFO - Total resource usage - Wall time: 1232s; CPU: 13.0%; Read bytes: 0; Write bytes: 562208768; Read time: 0; Write time: 492760 07:10:54 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 239267840; Read time: 0; Write time: 322800 07:10:54 INFO - run-tests - Wall time: 1216s; CPU: 13.0%; Read bytes: 0; Write bytes: 322940928; Read time: 0; Write time: 169960 07:10:54 INFO - Running post-run listener: _upload_blobber_files 07:10:54 INFO - Blob upload gear active. 07:10:54 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 07:10:54 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:10:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 07:10:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 07:10:55 INFO - (blobuploader) - INFO - Open directory for files ... 07:10:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 07:10:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:10:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:10:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:10:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:10:56 INFO - (blobuploader) - INFO - Done attempting. 07:10:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:10:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:10:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:10:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:10:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:10:56 INFO - (blobuploader) - INFO - Done attempting. 07:10:56 INFO - (blobuploader) - INFO - Iteration through files over. 07:10:56 INFO - Return code: 0 07:10:56 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 07:10:56 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 07:10:56 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac2915c48234ef5c21c11e3b3d32d740185849984aa08703a120755dad0c4976bba4acda7ba1cae5f7f02817cb5a3dae5cd14a6decd644db1b11e7c12a82a0b9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/baf39392ca8869757c7c4a5d73514330af8a4893b37102657f2bb7e50b49e36c21df66425dc3a3fa0c8d2d9609f7a189a76cc0b01400b0304d0eb6b5cce2db1d"} 07:10:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 07:10:56 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 07:10:56 INFO - Contents: 07:10:56 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac2915c48234ef5c21c11e3b3d32d740185849984aa08703a120755dad0c4976bba4acda7ba1cae5f7f02817cb5a3dae5cd14a6decd644db1b11e7c12a82a0b9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/baf39392ca8869757c7c4a5d73514330af8a4893b37102657f2bb7e50b49e36c21df66425dc3a3fa0c8d2d9609f7a189a76cc0b01400b0304d0eb6b5cce2db1d"} 07:10:56 INFO - Copying logs to upload dir... 07:10:56 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1277.205381 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-01-07 07:10:55.312267) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-07 07:10:55.315531) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1452172380.565067-985256072 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac2915c48234ef5c21c11e3b3d32d740185849984aa08703a120755dad0c4976bba4acda7ba1cae5f7f02817cb5a3dae5cd14a6decd644db1b11e7c12a82a0b9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/baf39392ca8869757c7c4a5d73514330af8a4893b37102657f2bb7e50b49e36c21df66425dc3a3fa0c8d2d9609f7a189a76cc0b01400b0304d0eb6b5cce2db1d"} build_url:https://queue.taskcluster.net/v1/task/ZRitCUtFTVa9LyEsFM33UA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011160 build_url: 'https://queue.taskcluster.net/v1/task/ZRitCUtFTVa9LyEsFM33UA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac2915c48234ef5c21c11e3b3d32d740185849984aa08703a120755dad0c4976bba4acda7ba1cae5f7f02817cb5a3dae5cd14a6decd644db1b11e7c12a82a0b9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/baf39392ca8869757c7c4a5d73514330af8a4893b37102657f2bb7e50b49e36c21df66425dc3a3fa0c8d2d9609f7a189a76cc0b01400b0304d0eb6b5cce2db1d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-07 07:10:55.339715) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 07:10:55.340102) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1452172380.565067-985256072 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004507 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 07:10:55.425058) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-07 07:10:55.425452) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-07 07:10:55.425835) ========= ========= Total master_lag: 0.21 =========