builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-050 starttime: 1450928964.58 results: success (0) buildid: 20151223173011 builduid: d6a193cd6b4e4d6aad2cc051782cdda6 revision: 1ef0360a8bb223c64972e32f6a0ae3f460add33d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-23 19:49:24.583451) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-23 19:49:24.583896) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-23 19:49:24.584203) ========= 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=d3f2be9b0713ec03b22325b2000001be-1450928065.951739-1081682117 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006338 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-23 19:49:24.608842) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-23 19:49:24.609167) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-23 19:49:24.637403) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 19:49:24.638042) ========= 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=d3f2be9b0713ec03b22325b2000001be-1450928065.951739-1081682117 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.029309 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 19:49:24.689019) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-23 19:49:24.689325) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-23 19:49:24.689685) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 19:49:24.689961) ========= 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=d3f2be9b0713ec03b22325b2000001be-1450928065.951739-1081682117 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-23 19:49:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 47.3M=0s 2015-12-23 19:49:24 (47.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.230836 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 19:49:24.933120) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 19:49:24.933437) ========= 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=d3f2be9b0713ec03b22325b2000001be-1450928065.951739-1081682117 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.075641 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 19:49:25.019861) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 19:49:25.020233) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1ef0360a8bb223c64972e32f6a0ae3f460add33d --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 1ef0360a8bb223c64972e32f6a0ae3f460add33d --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=d3f2be9b0713ec03b22325b2000001be-1450928065.951739-1081682117 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-23 19:49:25,112 truncating revision to first 12 chars 2015-12-23 19:49:25,112 Setting DEBUG logging. 2015-12-23 19:49:25,112 attempt 1/10 2015-12-23 19:49:25,112 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1ef0360a8bb2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-23 19:49:25,384 unpacking tar archive at: fx-team-1ef0360a8bb2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.560400 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 19:49:25.594206) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-23 19:49:25.594495) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-23 19:49:25.603213) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-23 19:49:25.603492) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-23 19:49:25.603901) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2015-12-23 19:49:25.604203) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=d3f2be9b0713ec03b22325b2000001be-1450928065.951739-1081682117 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:49:25 INFO - MultiFileLogger online at 20151223 19:49:25 in /builds/slave/test-pgo 19:49:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 19:49:25 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 19:49:25 INFO - {'append_to_log': False, 19:49:25 INFO - 'base_work_dir': '/builds/slave/test-pgo', 19:49:25 INFO - 'blob_upload_branch': 'Fx-Team', 19:49:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 19:49:25 INFO - 'branch': 'Fx-Team', 19:49:25 INFO - 'buildbot_json_path': 'buildprops.json', 19:49:25 INFO - 'config_files': ('talos/linux_config.py',), 19:49:25 INFO - 'default_actions': ('clobber', 19:49:25 INFO - 'read-buildbot-config', 19:49:25 INFO - 'download-and-extract', 19:49:25 INFO - 'populate-webroot', 19:49:25 INFO - 'create-virtualenv', 19:49:25 INFO - 'install', 19:49:25 INFO - 'run-tests'), 19:49:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:49:25 INFO - 'download_minidump_stackwalk': True, 19:49:25 INFO - 'download_symbols': 'ondemand', 19:49:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:49:25 INFO - 'tooltool.py': '/tools/tooltool.py', 19:49:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:49:25 INFO - '/tools/misc-python/virtualenv.py')}, 19:49:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:49:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:49:25 INFO - 'installer_path': 'installer.exe', 19:49:25 INFO - 'log_level': 'info', 19:49:25 INFO - 'log_name': 'talos', 19:49:25 INFO - 'log_to_console': True, 19:49:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:49:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:49:25 INFO - 'opt_config_files': (), 19:49:25 INFO - 'pip_index': False, 19:49:25 INFO - 'sps_profile': False, 19:49:25 INFO - 'sps_profile_interval': 0, 19:49:25 INFO - 'suite': 'dromaeojs', 19:49:25 INFO - 'system_bits': '64', 19:49:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:49:25 INFO - 'title': 'talos-linux64-ix-050', 19:49:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:49:25 INFO - 'use_talos_json': True, 19:49:25 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 19:49:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:49:25 INFO - 'work_dir': 'build'} 19:49:25 INFO - ##### 19:49:25 INFO - ##### Running clobber step. 19:49:25 INFO - ##### 19:49:25 INFO - Running pre-action listener: _resource_record_pre_action 19:49:25 INFO - Running main action method: clobber 19:49:25 INFO - rmtree: /builds/slave/test-pgo/build 19:49:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 19:49:31 INFO - Running post-action listener: _resource_record_post_action 19:49:31 INFO - ##### 19:49:31 INFO - ##### Running read-buildbot-config step. 19:49:31 INFO - ##### 19:49:31 INFO - Running pre-action listener: _resource_record_pre_action 19:49:31 INFO - Running main action method: read_buildbot_config 19:49:31 INFO - Using buildbot properties: 19:49:31 INFO - { 19:49:31 INFO - "project": "", 19:49:31 INFO - "product": "firefox", 19:49:31 INFO - "script_repo_revision": "production", 19:49:31 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 19:49:31 INFO - "repository": "", 19:49:31 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 19:49:31 INFO - "buildid": "20151223173011", 19:49:31 INFO - "pgo_build": "True", 19:49:31 INFO - "basedir": "/builds/slave/test-pgo", 19:49:31 INFO - "buildnumber": 851, 19:49:31 INFO - "slavename": "talos-linux64-ix-050", 19:49:31 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:49:31 INFO - "platform": "ubuntu64_hw", 19:49:31 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 19:49:31 INFO - "branch": "fx-team", 19:49:31 INFO - "repo_path": "integration/fx-team", 19:49:31 INFO - "revision": "1ef0360a8bb223c64972e32f6a0ae3f460add33d", 19:49:31 INFO - "stage_platform": "linux64-pgo", 19:49:31 INFO - "builduid": "d6a193cd6b4e4d6aad2cc051782cdda6", 19:49:31 INFO - "slavebuilddir": "test" 19:49:31 INFO - } 19:49:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/e77BAwq3TPKhnS84yG9ONQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 19:49:31 INFO - Running post-action listener: _resource_record_post_action 19:49:31 INFO - ##### 19:49:31 INFO - ##### Running download-and-extract step. 19:49:31 INFO - ##### 19:49:31 INFO - Running pre-action listener: _resource_record_pre_action 19:49:31 INFO - Running main action method: download_and_extract 19:49:31 INFO - mkdir: /builds/slave/test-pgo/build/tests 19:49:31 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')]} 19:49:31 INFO - https://queue.taskcluster.net/v1/task/e77BAwq3TPKhnS84yG9ONQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 19:49:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e77BAwq3TPKhnS84yG9ONQ/artifacts/public/build/test_packages.json 19:49:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e77BAwq3TPKhnS84yG9ONQ/artifacts/public/build/test_packages.json 19:49:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e77BAwq3TPKhnS84yG9ONQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 19:49:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e77BAwq3TPKhnS84yG9ONQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 19:49:33 INFO - Downloaded 1302 bytes. 19:49:33 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 19:49:33 INFO - Using the following test package requirements: 19:49:33 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:49:33 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:49:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:49:33 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:49:33 INFO - u'jsshell-linux-x86_64.zip'], 19:49:33 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:49:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:49:33 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:49:33 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:49:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:49:33 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:49:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:49:33 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:49:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:49:33 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:49:33 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:49:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:49:33 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:49:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:49:33 INFO - https://queue.taskcluster.net/v1/task/e77BAwq3TPKhnS84yG9ONQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:49:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e77BAwq3TPKhnS84yG9ONQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:49:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e77BAwq3TPKhnS84yG9ONQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:49:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e77BAwq3TPKhnS84yG9ONQ/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 19:49:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e77BAwq3TPKhnS84yG9ONQ/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 19:49:37 INFO - Downloaded 23182260 bytes. 19:49:37 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 19:49:37 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:49:37 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 19:49:39 INFO - Return code: 0 19:49:39 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 19:49:39 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')]} 19:49:39 INFO - https://queue.taskcluster.net/v1/task/e77BAwq3TPKhnS84yG9ONQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:49:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e77BAwq3TPKhnS84yG9ONQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:49:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e77BAwq3TPKhnS84yG9ONQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:49:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e77BAwq3TPKhnS84yG9ONQ/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 19:49:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e77BAwq3TPKhnS84yG9ONQ/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 19:49:49 INFO - Downloaded 23182260 bytes. 19:49:49 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 19:49:49 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:49:49 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 19:49:50 INFO - Return code: 0 19:49:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:49:50 INFO - https://queue.taskcluster.net/v1/task/e77BAwq3TPKhnS84yG9ONQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:49:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e77BAwq3TPKhnS84yG9ONQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:49:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e77BAwq3TPKhnS84yG9ONQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:49:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e77BAwq3TPKhnS84yG9ONQ/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 19:49:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e77BAwq3TPKhnS84yG9ONQ/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 19:49:51 INFO - Downloaded 11132277 bytes. 19:49:51 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 19:49:51 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:49:51 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 19:49:51 INFO - Return code: 0 19:49:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:49:51 INFO - https://queue.taskcluster.net/v1/task/e77BAwq3TPKhnS84yG9ONQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:49:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e77BAwq3TPKhnS84yG9ONQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:49:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e77BAwq3TPKhnS84yG9ONQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:49:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e77BAwq3TPKhnS84yG9ONQ/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 19:49:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e77BAwq3TPKhnS84yG9ONQ/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 19:49:53 INFO - Downloaded 54837204 bytes. 19:49:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/e77BAwq3TPKhnS84yG9ONQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:49:53 INFO - mkdir: /builds/slave/test-pgo/properties 19:49:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 19:49:53 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 19:49:53 INFO - Contents: 19:49:53 INFO - build_url:https://queue.taskcluster.net/v1/task/e77BAwq3TPKhnS84yG9ONQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:49:53 INFO - Running post-action listener: _resource_record_post_action 19:49:53 INFO - Running post-action listener: set_extra_try_arguments 19:49:53 INFO - ##### 19:49:53 INFO - ##### Running populate-webroot step. 19:49:53 INFO - ##### 19:49:53 INFO - Running pre-action listener: _resource_record_pre_action 19:49:53 INFO - Running main action method: populate_webroot 19:49:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:49:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:49:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:49:53 INFO - '--tppagecycles', 19:49:53 INFO - '7'], 19:49:53 INFO - 'tests': ['tsvgm']}}, 19:49:53 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:49:53 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:49:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:49:53 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:49:53 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:49:53 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:49:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:49:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:49:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:49:53 INFO - 'talos_options': ['--e10s'], 19:49:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:49:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:49:53 INFO - 'tests': ['damp', 'tps']}, 19:49:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:49:53 INFO - 'talos_options': ['--e10s'], 19:49:53 INFO - 'tests': ['damp', 'tps']}, 19:49:53 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:49:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:49:53 INFO - 'other': {'tests': ['a11yr', 19:49:53 INFO - 'ts_paint', 19:49:53 INFO - 'tpaint', 19:49:53 INFO - 'sessionrestore', 19:49:53 INFO - 'sessionrestore_no_auto_restore']}, 19:49:53 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:49:53 INFO - 'tests': ['a11yr', 19:49:53 INFO - 'ts_paint', 19:49:53 INFO - 'tpaint', 19:49:53 INFO - 'sessionrestore', 19:49:53 INFO - 'sessionrestore_no_auto_restore']}, 19:49:53 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:49:53 INFO - 'tests': ['a11yr', 19:49:53 INFO - 'ts_paint', 19:49:53 INFO - 'tpaint', 19:49:53 INFO - 'sessionrestore', 19:49:53 INFO - 'sessionrestore_no_auto_restore']}, 19:49:53 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:49:53 INFO - 'tests': ['a11yr', 19:49:53 INFO - 'ts_paint', 19:49:53 INFO - 'tpaint', 19:49:53 INFO - 'sessionrestore', 19:49:53 INFO - 'sessionrestore_no_auto_restore']}, 19:49:53 INFO - 'other_l64': {'tests': ['a11yr', 19:49:53 INFO - 'ts_paint', 19:49:53 INFO - 'tpaint', 19:49:53 INFO - 'sessionrestore', 19:49:53 INFO - 'sessionrestore_no_auto_restore']}, 19:49:53 INFO - 'other_nol64': {'tests': ['a11yr', 19:49:53 INFO - 'ts_paint', 19:49:53 INFO - 'tpaint', 19:49:53 INFO - 'sessionrestore', 19:49:53 INFO - 'sessionrestore_no_auto_restore']}, 19:49:53 INFO - 'svgr': {'tests': ['tsvgx', 19:49:53 INFO - 'tsvgr_opacity', 19:49:53 INFO - 'tart', 19:49:53 INFO - 'tscrollx', 19:49:53 INFO - 'cart']}, 19:49:53 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:49:53 INFO - 'tests': ['tsvgx', 19:49:53 INFO - 'tsvgr_opacity', 19:49:53 INFO - 'tart', 19:49:53 INFO - 'tscrollx', 19:49:53 INFO - 'cart']}, 19:49:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:49:53 INFO - 'tests': ['tp5o']}, 19:49:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:49:53 INFO - 'talos_options': ['--e10s'], 19:49:53 INFO - 'tests': ['tp5o']}, 19:49:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:49:53 INFO - 'talos_options': ['--xperf_path', 19:49:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:49:53 INFO - 'tests': ['tp5n']}, 19:49:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:49:53 INFO - 'talos_options': ['--e10s', 19:49:53 INFO - '--xperf_path', 19:49:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:49:53 INFO - 'tests': ['tp5n']}}, 19:49:53 INFO - 'talos.zip': {'path': '', 19:49:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:49:53 INFO - Running post-action listener: _resource_record_post_action 19:49:53 INFO - ##### 19:49:53 INFO - ##### Running create-virtualenv step. 19:49:53 INFO - ##### 19:49:53 INFO - Running pre-action listener: _resource_record_pre_action 19:49:53 INFO - Running main action method: create_virtualenv 19:49:53 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 19:49:53 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 19:49:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 19:49:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:49:53 INFO - Using real prefix '/usr' 19:49:53 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 19:49:54 INFO - Installing distribute.............................................................................................................................................................................................done. 19:49:56 INFO - Installing pip.................done. 19:49:56 INFO - Return code: 0 19:49:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 19: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')]} 19:49:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:49:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19: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')]} 19:49:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:49:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:56 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 0x7fee1ec9af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xefe630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8f840>, '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 0xefc6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xefcb60>, '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': 'd3f2be9b0713ec03b22325b2000001be-1450928065.951739-1081682117', '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 19:49:56 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 19:49:56 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 19:49:56 INFO - Using env: {'DISPLAY': ':0', 19:49:56 INFO - 'HOME': '/home/cltbld', 19:49:56 INFO - 'LANG': 'en_US.UTF-8', 19:49:56 INFO - 'LANGUAGE': 'en_US:en', 19:49:56 INFO - 'LOGNAME': 'cltbld', 19:49:56 INFO - 'MAIL': '/var/mail/cltbld', 19:49:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:49:56 INFO - 'MOZ_NO_REMOTE': '1', 19:49:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:49:56 INFO - 'NO_EM_RESTART': '1', 19:49:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:49:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:49:56 INFO - 'PWD': '/builds/slave/test-pgo', 19:49:56 INFO - 'SHELL': '/bin/bash', 19:49:56 INFO - 'SHLVL': '1', 19:49:56 INFO - 'TERM': 'linux', 19:49:56 INFO - 'TMOUT': '86400', 19:49:56 INFO - 'USER': 'cltbld', 19:49:56 INFO - 'XDG_SESSION_COOKIE': 'd3f2be9b0713ec03b22325b2000001be-1450928065.951739-1081682117', 19:49:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:49:56 INFO - '_': '/tools/buildbot/bin/python'} 19:49:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:49:56 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 19:49:56 INFO - Cleaning up... 19:49:56 INFO - Return code: 0 19:49:56 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 19: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')]} 19:49:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:49:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19: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')]} 19:49:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:49:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:56 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 0x7fee1ec9af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xefe630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8f840>, '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 0xefc6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xefcb60>, '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': 'd3f2be9b0713ec03b22325b2000001be-1450928065.951739-1081682117', '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 19:49:56 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 19:49:56 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 19:49:56 INFO - Using env: {'DISPLAY': ':0', 19:49:56 INFO - 'HOME': '/home/cltbld', 19:49:56 INFO - 'LANG': 'en_US.UTF-8', 19:49:56 INFO - 'LANGUAGE': 'en_US:en', 19:49:56 INFO - 'LOGNAME': 'cltbld', 19:49:56 INFO - 'MAIL': '/var/mail/cltbld', 19:49:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:49:56 INFO - 'MOZ_NO_REMOTE': '1', 19:49:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:49:56 INFO - 'NO_EM_RESTART': '1', 19:49:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:49:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:49:56 INFO - 'PWD': '/builds/slave/test-pgo', 19:49:56 INFO - 'SHELL': '/bin/bash', 19:49:56 INFO - 'SHLVL': '1', 19:49:56 INFO - 'TERM': 'linux', 19:49:56 INFO - 'TMOUT': '86400', 19:49:56 INFO - 'USER': 'cltbld', 19:49:56 INFO - 'XDG_SESSION_COOKIE': 'd3f2be9b0713ec03b22325b2000001be-1450928065.951739-1081682117', 19:49:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:49:56 INFO - '_': '/tools/buildbot/bin/python'} 19:49:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:49:56 INFO - Downloading/unpacking psutil>=0.7.1 19:49:56 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 19:49:56 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 19:49:56 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 19:49:56 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 19:49:56 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 19:49:56 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 19:49:58 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 19:49:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 19:49:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 19:49:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:49:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:49:58 INFO - Installing collected packages: psutil 19:49:58 INFO - Running setup.py install for psutil 19:49:58 INFO - building 'psutil._psutil_linux' extension 19:49:58 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 19:49:58 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 19:49:58 INFO - building 'psutil._psutil_posix' extension 19:49:58 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 19:49:58 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 19:49:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:49:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:49:58 INFO - Successfully installed psutil 19:49:58 INFO - Cleaning up... 19:49:58 INFO - Return code: 0 19:49:58 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 19:49:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:49:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:49:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:49:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:49:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:58 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 0x7fee1ec9af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xefe630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8f840>, '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 0xefc6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xefcb60>, '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': 'd3f2be9b0713ec03b22325b2000001be-1450928065.951739-1081682117', '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 19:49:58 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 19:49:58 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 19:49:58 INFO - Using env: {'DISPLAY': ':0', 19:49:58 INFO - 'HOME': '/home/cltbld', 19:49:58 INFO - 'LANG': 'en_US.UTF-8', 19:49:58 INFO - 'LANGUAGE': 'en_US:en', 19:49:58 INFO - 'LOGNAME': 'cltbld', 19:49:58 INFO - 'MAIL': '/var/mail/cltbld', 19:49:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:49:58 INFO - 'MOZ_NO_REMOTE': '1', 19:49:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:49:58 INFO - 'NO_EM_RESTART': '1', 19:49:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:49:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:49:58 INFO - 'PWD': '/builds/slave/test-pgo', 19:49:58 INFO - 'SHELL': '/bin/bash', 19:49:58 INFO - 'SHLVL': '1', 19:49:58 INFO - 'TERM': 'linux', 19:49:58 INFO - 'TMOUT': '86400', 19:49:58 INFO - 'USER': 'cltbld', 19:49:58 INFO - 'XDG_SESSION_COOKIE': 'd3f2be9b0713ec03b22325b2000001be-1450928065.951739-1081682117', 19:49:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:49:58 INFO - '_': '/tools/buildbot/bin/python'} 19:49:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:49:59 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:49:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:49:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:49:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:49:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:49:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:49:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:50:00 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:50:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 19:50:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:50:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:50:00 INFO - Installing collected packages: mozsystemmonitor 19:50:00 INFO - Running setup.py install for mozsystemmonitor 19:50:00 INFO - Successfully installed mozsystemmonitor 19:50:00 INFO - Cleaning up... 19:50:00 INFO - Return code: 0 19:50:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 19: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')]} 19:50:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:50:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19: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')]} 19:50:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:50:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19: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', '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 0x7fee1ec9af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xefe630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8f840>, '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 0xefc6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xefcb60>, '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': 'd3f2be9b0713ec03b22325b2000001be-1450928065.951739-1081682117', '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 19: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', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 19: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 blobuploader==1.2.4 19:50:00 INFO - Using env: {'DISPLAY': ':0', 19:50:00 INFO - 'HOME': '/home/cltbld', 19:50:00 INFO - 'LANG': 'en_US.UTF-8', 19:50:00 INFO - 'LANGUAGE': 'en_US:en', 19:50:00 INFO - 'LOGNAME': 'cltbld', 19:50:00 INFO - 'MAIL': '/var/mail/cltbld', 19:50:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:50:00 INFO - 'MOZ_NO_REMOTE': '1', 19:50:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:50:00 INFO - 'NO_EM_RESTART': '1', 19:50:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:50:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:50:00 INFO - 'PWD': '/builds/slave/test-pgo', 19:50:00 INFO - 'SHELL': '/bin/bash', 19:50:00 INFO - 'SHLVL': '1', 19:50:00 INFO - 'TERM': 'linux', 19:50:00 INFO - 'TMOUT': '86400', 19:50:00 INFO - 'USER': 'cltbld', 19:50:00 INFO - 'XDG_SESSION_COOKIE': 'd3f2be9b0713ec03b22325b2000001be-1450928065.951739-1081682117', 19:50:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:50:00 INFO - '_': '/tools/buildbot/bin/python'} 19:50:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:50:01 INFO - Downloading/unpacking blobuploader==1.2.4 19: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 19: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 19: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 19: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 19: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 19: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 19:50:02 INFO - Downloading blobuploader-1.2.4.tar.gz 19:50:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 19:50:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:50:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:50:02 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 19:50:02 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 19:50:02 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 19:50:02 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 19:50:02 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 19:50:02 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 19:50:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 19:50:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 19:50:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19: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 19: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 19: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 19: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 19: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 19: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 19:50:03 INFO - Downloading docopt-0.6.1.tar.gz 19:50:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 19:50:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 19:50:03 INFO - Installing collected packages: blobuploader, requests, docopt 19:50:03 INFO - Running setup.py install for blobuploader 19:50:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:50:03 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 19:50:03 INFO - Running setup.py install for requests 19:50:04 INFO - Running setup.py install for docopt 19:50:04 INFO - Successfully installed blobuploader requests docopt 19:50:04 INFO - Cleaning up... 19:50:04 INFO - Return code: 0 19:50:04 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:50:04 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')]} 19:50:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:50:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:50:04 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')]} 19:50:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:50:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:50:04 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 0x7fee1ec9af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xefe630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8f840>, '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 0xefc6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xefcb60>, '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': 'd3f2be9b0713ec03b22325b2000001be-1450928065.951739-1081682117', '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 19:50:04 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 19:50:04 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 19:50:04 INFO - Using env: {'DISPLAY': ':0', 19:50:04 INFO - 'HOME': '/home/cltbld', 19:50:04 INFO - 'LANG': 'en_US.UTF-8', 19:50:04 INFO - 'LANGUAGE': 'en_US:en', 19:50:04 INFO - 'LOGNAME': 'cltbld', 19:50:04 INFO - 'MAIL': '/var/mail/cltbld', 19:50:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:50:04 INFO - 'MOZ_NO_REMOTE': '1', 19:50:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:50:04 INFO - 'NO_EM_RESTART': '1', 19:50:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:50:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:50:04 INFO - 'PWD': '/builds/slave/test-pgo', 19:50:04 INFO - 'SHELL': '/bin/bash', 19:50:04 INFO - 'SHLVL': '1', 19:50:04 INFO - 'TERM': 'linux', 19:50:04 INFO - 'TMOUT': '86400', 19:50:04 INFO - 'USER': 'cltbld', 19:50:04 INFO - 'XDG_SESSION_COOKIE': 'd3f2be9b0713ec03b22325b2000001be-1450928065.951739-1081682117', 19:50:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:50:04 INFO - '_': '/tools/buildbot/bin/python'} 19:50:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:50:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:50:04 INFO - Running setup.py (path:/tmp/pip-JwsvdW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:50:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:50:04 INFO - Running setup.py (path:/tmp/pip-l6CXlx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:50:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:50:04 INFO - Running setup.py (path:/tmp/pip-PV3wl3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:50:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:50:04 INFO - Running setup.py (path:/tmp/pip-R3oCq_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:50:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:50:04 INFO - Running setup.py (path:/tmp/pip-BOOTBc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:50:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:50:04 INFO - Running setup.py (path:/tmp/pip-vuEkza-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:50:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:50:04 INFO - Running setup.py (path:/tmp/pip-tg6snM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:50:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:50:04 INFO - Running setup.py (path:/tmp/pip-yKMCa_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:50:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:50:04 INFO - Running setup.py (path:/tmp/pip-_8zZe_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:50:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:50:05 INFO - Running setup.py (path:/tmp/pip-kBTka_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:50:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:50:05 INFO - Running setup.py (path:/tmp/pip-OtHXEL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:50:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:50:05 INFO - Running setup.py (path:/tmp/pip-IUnpHk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:50:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:50:05 INFO - Running setup.py (path:/tmp/pip-gcq94s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:50:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:50:05 INFO - Running setup.py (path:/tmp/pip-arxMUP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:50:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:50:05 INFO - Running setup.py (path:/tmp/pip-0RKsxg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:50:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:50:05 INFO - Running setup.py (path:/tmp/pip-hlPh7f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:50:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:50:05 INFO - Running setup.py (path:/tmp/pip-oX9fGf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:50:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:50:05 INFO - Running setup.py install for manifestparser 19:50:05 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 19:50:05 INFO - Running setup.py install for mozcrash 19:50:05 INFO - Running setup.py install for mozdebug 19:50:05 INFO - Running setup.py install for mozdevice 19:50:06 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 19:50:06 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 19:50:06 INFO - Running setup.py install for mozfile 19:50:06 INFO - Running setup.py install for mozhttpd 19:50:06 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 19:50:06 INFO - Running setup.py install for mozinfo 19:50:06 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 19:50:06 INFO - Running setup.py install for mozInstall 19:50:06 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 19:50:06 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 19:50:06 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 19:50:06 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 19:50:06 INFO - Running setup.py install for mozleak 19:50:06 INFO - Running setup.py install for mozlog 19:50:06 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 19:50:06 INFO - Running setup.py install for moznetwork 19:50:06 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 19:50:06 INFO - Running setup.py install for mozprocess 19:50:06 INFO - Running setup.py install for mozprofile 19:50:06 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 19:50:06 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 19:50:06 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 19:50:06 INFO - Running setup.py install for mozrunner 19:50:07 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 19:50:07 INFO - Running setup.py install for mozscreenshot 19:50:07 INFO - Running setup.py install for moztest 19:50:07 INFO - Running setup.py install for mozversion 19:50:07 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 19:50:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:50:07 INFO - Cleaning up... 19:50:07 INFO - Return code: 0 19:50:07 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:50:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:50:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:50:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:50:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:50:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:50:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:50:07 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 0x7fee1ec9af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xefe630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8f840>, '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 0xefc6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xefcb60>, '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': 'd3f2be9b0713ec03b22325b2000001be-1450928065.951739-1081682117', '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 19:50:07 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 19:50:07 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 19:50:07 INFO - Using env: {'DISPLAY': ':0', 19:50:07 INFO - 'HOME': '/home/cltbld', 19:50:07 INFO - 'LANG': 'en_US.UTF-8', 19:50:07 INFO - 'LANGUAGE': 'en_US:en', 19:50:07 INFO - 'LOGNAME': 'cltbld', 19:50:07 INFO - 'MAIL': '/var/mail/cltbld', 19:50:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:50:07 INFO - 'MOZ_NO_REMOTE': '1', 19:50:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:50:07 INFO - 'NO_EM_RESTART': '1', 19:50:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:50:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:50:07 INFO - 'PWD': '/builds/slave/test-pgo', 19:50:07 INFO - 'SHELL': '/bin/bash', 19:50:07 INFO - 'SHLVL': '1', 19:50:07 INFO - 'TERM': 'linux', 19:50:07 INFO - 'TMOUT': '86400', 19:50:07 INFO - 'USER': 'cltbld', 19:50:07 INFO - 'XDG_SESSION_COOKIE': 'd3f2be9b0713ec03b22325b2000001be-1450928065.951739-1081682117', 19:50:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:50:07 INFO - '_': '/tools/buildbot/bin/python'} 19:50:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:50:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:50:07 INFO - Running setup.py (path:/tmp/pip-Fo9DjZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:50:07 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)) 19:50:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:50:07 INFO - Running setup.py (path:/tmp/pip-8WyxkB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:50:07 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)) 19:50:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:50:07 INFO - Running setup.py (path:/tmp/pip-P860MR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:50:07 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)) 19:50:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:50:07 INFO - Running setup.py (path:/tmp/pip-bfGsE0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:50:07 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)) 19:50:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:50:07 INFO - Running setup.py (path:/tmp/pip-xfZdKV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:50:07 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)) 19:50:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:50:07 INFO - Running setup.py (path:/tmp/pip-IpDJAw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:50:08 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)) 19:50:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:50:08 INFO - Running setup.py (path:/tmp/pip-o8ZLdi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:50:08 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)) 19:50:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:50:08 INFO - Running setup.py (path:/tmp/pip-1WBgqO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:50:08 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)) 19:50:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:50:08 INFO - Running setup.py (path:/tmp/pip-Fw4eJ9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:50:08 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)) 19:50:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:50:08 INFO - Running setup.py (path:/tmp/pip-LeqVka-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:50:08 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)) 19:50:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:50:08 INFO - Running setup.py (path:/tmp/pip-sbG74x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:50:08 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)) 19:50:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:50:08 INFO - Running setup.py (path:/tmp/pip-WZ6XfI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:50:08 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)) 19:50:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:50:08 INFO - Running setup.py (path:/tmp/pip-yKAWsE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:50:08 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)) 19:50:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:50:08 INFO - Running setup.py (path:/tmp/pip-5DHcNo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:50:08 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)) 19:50:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:50:08 INFO - Running setup.py (path:/tmp/pip-KDVkEt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:50:08 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)) 19:50:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:50:08 INFO - Running setup.py (path:/tmp/pip-h4CV3N-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:50:08 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)) 19:50:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:50:08 INFO - Running setup.py (path:/tmp/pip-Twui5g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:50:08 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)) 19:50:08 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)) 19:50:08 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)) 19:50:08 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)) 19:50:08 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)) 19:50:08 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)) 19:50:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 19: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 19: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 19: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 19: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 19: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 19: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 19:50:10 INFO - Downloading blessings-1.5.1.tar.gz 19:50:10 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 19:50:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 19:50:10 INFO - Installing collected packages: blessings 19:50:10 INFO - Running setup.py install for blessings 19:50:10 INFO - Successfully installed blessings 19:50:10 INFO - Cleaning up... 19:50:10 INFO - Return code: 0 19:50:10 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 19:50:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:50:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:50:10 INFO - Reading from file tmpfile_stdout 19:50:10 INFO - Current package versions: 19:50:10 INFO - argparse == 1.2.1 19:50:10 INFO - blessings == 1.5.1 19:50:10 INFO - blobuploader == 1.2.4 19:50:10 INFO - docopt == 0.6.1 19:50:10 INFO - manifestparser == 1.1 19:50:10 INFO - mozInstall == 1.12 19:50:10 INFO - mozcrash == 0.16 19:50:10 INFO - mozdebug == 0.1 19:50:10 INFO - mozdevice == 0.47 19:50:10 INFO - mozfile == 1.2 19:50:10 INFO - mozhttpd == 0.7 19:50:10 INFO - mozinfo == 0.9 19:50:10 INFO - mozleak == 0.1 19:50:10 INFO - mozlog == 3.1 19:50:10 INFO - moznetwork == 0.27 19:50:10 INFO - mozprocess == 0.22 19:50:10 INFO - mozprofile == 0.28 19:50:10 INFO - mozrunner == 6.11 19:50:10 INFO - mozscreenshot == 0.1 19:50:10 INFO - mozsystemmonitor == 0.0 19:50:10 INFO - moztest == 0.7 19:50:10 INFO - mozversion == 1.4 19:50:10 INFO - psutil == 3.1.1 19:50:10 INFO - requests == 1.2.3 19:50:10 INFO - wsgiref == 0.1.2 19:50:10 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:50:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:50:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:50:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:50:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:50:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:50:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:50:10 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 0x7fee1ec9af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xefe630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8f840>, '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 0xefc6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xefcb60>, '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': 'd3f2be9b0713ec03b22325b2000001be-1450928065.951739-1081682117', '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 19:50:10 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 19:50:10 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 19:50:10 INFO - Using env: {'DISPLAY': ':0', 19:50:10 INFO - 'HOME': '/home/cltbld', 19:50:10 INFO - 'LANG': 'en_US.UTF-8', 19:50:10 INFO - 'LANGUAGE': 'en_US:en', 19:50:10 INFO - 'LOGNAME': 'cltbld', 19:50:10 INFO - 'MAIL': '/var/mail/cltbld', 19:50:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:50:10 INFO - 'MOZ_NO_REMOTE': '1', 19:50:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:50:10 INFO - 'NO_EM_RESTART': '1', 19:50:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:50:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:50:10 INFO - 'PWD': '/builds/slave/test-pgo', 19:50:10 INFO - 'SHELL': '/bin/bash', 19:50:10 INFO - 'SHLVL': '1', 19:50:10 INFO - 'TERM': 'linux', 19:50:10 INFO - 'TMOUT': '86400', 19:50:10 INFO - 'USER': 'cltbld', 19:50:10 INFO - 'XDG_SESSION_COOKIE': 'd3f2be9b0713ec03b22325b2000001be-1450928065.951739-1081682117', 19:50:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:50:10 INFO - '_': '/tools/buildbot/bin/python'} 19:50:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:50:11 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)) 19:50:11 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)) 19:50:11 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)) 19:50:11 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)) 19:50:11 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)) 19:50:11 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)) 19:50:11 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)) 19:50:11 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)) 19:50:11 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)) 19:50:11 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)) 19:50:11 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)) 19:50:11 INFO - Cleaning up... 19:50:11 INFO - Return code: 0 19:50:11 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 19:50:11 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')]} 19:50:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:50:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:50:11 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')]} 19:50:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:50:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:50:11 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 0x7fee1ec9af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xefe630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8f840>, '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 0xefc6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xefcb60>, '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': 'd3f2be9b0713ec03b22325b2000001be-1450928065.951739-1081682117', '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 19:50:11 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 19:50:11 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 19:50:11 INFO - Using env: {'DISPLAY': ':0', 19:50:11 INFO - 'HOME': '/home/cltbld', 19:50:11 INFO - 'LANG': 'en_US.UTF-8', 19:50:11 INFO - 'LANGUAGE': 'en_US:en', 19:50:11 INFO - 'LOGNAME': 'cltbld', 19:50:11 INFO - 'MAIL': '/var/mail/cltbld', 19:50:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:50:11 INFO - 'MOZ_NO_REMOTE': '1', 19:50:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:50:11 INFO - 'NO_EM_RESTART': '1', 19:50:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:50:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:50:11 INFO - 'PWD': '/builds/slave/test-pgo', 19:50:11 INFO - 'SHELL': '/bin/bash', 19:50:11 INFO - 'SHLVL': '1', 19:50:11 INFO - 'TERM': 'linux', 19:50:11 INFO - 'TMOUT': '86400', 19:50:11 INFO - 'USER': 'cltbld', 19:50:11 INFO - 'XDG_SESSION_COOKIE': 'd3f2be9b0713ec03b22325b2000001be-1450928065.951739-1081682117', 19:50:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:50:11 INFO - '_': '/tools/buildbot/bin/python'} 19:50:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:50:11 INFO - Downloading/unpacking jsonschema 19:50:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:50:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:50:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:50:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:50:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:50:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:50:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:50:13 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 19:50:13 INFO - Downloading/unpacking functools32 (from jsonschema) 19: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 19: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 19: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 19: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 19: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 19: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 19:50:13 INFO - Downloading functools32-3.2.3-2.tar.gz 19:50:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 19:50:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 19:50:13 INFO - warning: no files found matching '*.txt' 19:50:13 INFO - no previously-included directories found matching 'build' 19:50:13 INFO - no previously-included directories found matching 'dist' 19:50:13 INFO - no previously-included directories found matching '.git*' 19:50:13 INFO - Installing collected packages: jsonschema, functools32 19:50:13 INFO - Running setup.py install for functools32 19:50:13 INFO - warning: no files found matching '*.txt' 19:50:13 INFO - no previously-included directories found matching 'build' 19:50:13 INFO - no previously-included directories found matching 'dist' 19:50:13 INFO - no previously-included directories found matching '.git*' 19:50:13 INFO - Successfully installed jsonschema functools32 19:50:13 INFO - Cleaning up... 19:50:13 INFO - Return code: 0 19:50:13 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 19:50:13 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')]} 19:50:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:50:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:50:13 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')]} 19:50:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:50:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:50:13 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 0x7fee1ec9af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xefe630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8f840>, '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 0xefc6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xefcb60>, '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': 'd3f2be9b0713ec03b22325b2000001be-1450928065.951739-1081682117', '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 19:50:13 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 19:50:13 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 19:50:13 INFO - Using env: {'DISPLAY': ':0', 19:50:13 INFO - 'HOME': '/home/cltbld', 19:50:13 INFO - 'LANG': 'en_US.UTF-8', 19:50:13 INFO - 'LANGUAGE': 'en_US:en', 19:50:13 INFO - 'LOGNAME': 'cltbld', 19:50:13 INFO - 'MAIL': '/var/mail/cltbld', 19:50:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:50:13 INFO - 'MOZ_NO_REMOTE': '1', 19:50:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:50:13 INFO - 'NO_EM_RESTART': '1', 19:50:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:50:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:50:13 INFO - 'PWD': '/builds/slave/test-pgo', 19:50:13 INFO - 'SHELL': '/bin/bash', 19:50:13 INFO - 'SHLVL': '1', 19:50:13 INFO - 'TERM': 'linux', 19:50:13 INFO - 'TMOUT': '86400', 19:50:13 INFO - 'USER': 'cltbld', 19:50:13 INFO - 'XDG_SESSION_COOKIE': 'd3f2be9b0713ec03b22325b2000001be-1450928065.951739-1081682117', 19:50:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:50:13 INFO - '_': '/tools/buildbot/bin/python'} 19:50:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:50:13 INFO - Downloading/unpacking flake8 19: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 19: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 19: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 19: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 19: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 19: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 19:50:15 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:50:15 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 19:50:15 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:50:15 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 19:50:15 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 19:50:15 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 19:50:15 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 19:50:15 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 19:50:15 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 19:50:15 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:50:15 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 19:50:15 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:50:15 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 19:50:15 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 19:50:15 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 19:50:15 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 19:50:15 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 19:50:15 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 19:50:15 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 19:50:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:50:15 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 19:50:15 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 19:50:15 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 19:50:15 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 19:50:15 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 19:50:15 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 19:50:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 19:50:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 19:50:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:50:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:50:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:50:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:50:16 INFO - no previously-included directories found matching 'docs/_build' 19:50:16 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:50:16 INFO - Running setup.py install for pep8 19:50:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:50:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:50:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:50:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:50:16 INFO - no previously-included directories found matching 'docs/_build' 19:50:16 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 19:50:16 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:50:16 INFO - Cleaning up... 19:50:16 INFO - Return code: 0 19:50:16 INFO - Running post-action listener: _resource_record_post_action 19:50:16 INFO - Running post-action listener: _start_resource_monitoring 19:50:16 INFO - Starting resource monitoring. 19:50:16 INFO - ##### 19:50:16 INFO - ##### Running install step. 19:50:16 INFO - ##### 19:50:16 INFO - Running pre-action listener: _resource_record_pre_action 19:50:16 INFO - Running main action method: install 19:50:16 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:50:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:50:16 INFO - Reading from file tmpfile_stdout 19:50:16 INFO - Detecting whether we're running mozinstall >=1.0... 19:50:16 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 19:50:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 19:50:16 INFO - Reading from file tmpfile_stdout 19:50:16 INFO - Output received: 19:50:16 INFO - Usage: mozinstall [options] installer 19:50:16 INFO - Options: 19:50:16 INFO - -h, --help show this help message and exit 19:50:16 INFO - -d DEST, --destination=DEST 19:50:16 INFO - Directory to install application into. [default: 19:50:16 INFO - "/builds/slave/test-pgo"] 19:50:16 INFO - --app=APP Application being installed. [default: firefox] 19:50:16 INFO - mkdir: /builds/slave/test-pgo/build/application 19:50:16 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'] 19:50:16 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 19:50:32 INFO - Reading from file tmpfile_stdout 19:50:32 INFO - Output received: 19:50:32 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 19:50:32 INFO - Running post-action listener: _resource_record_post_action 19:50:32 INFO - ##### 19:50:32 INFO - ##### Running run-tests step. 19:50:32 INFO - ##### 19:50:32 INFO - Running pre-action listener: _resource_record_pre_action 19:50:32 INFO - Running main action method: run_tests 19:50:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 19:50:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 19:50:32 INFO - Python 2.7.3 19:50:32 INFO - Return code: 0 19:50:32 INFO - grabbing minidump binary from tooltool 19:50:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:50:32 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 0xf8f840>, '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 0xefc6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xefcb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 19:50:32 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 19:50:32 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 19:50:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:50:32 INFO - Return code: 0 19:50:32 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 19:50:32 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 19:50:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 19:50:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 19:50:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 19:50:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 19:50:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 19:50:33 INFO - Return code: 0 19:50:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/e77BAwq3TPKhnS84yG9ONQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 19:50:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/e77BAwq3TPKhnS84yG9ONQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-050 --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 19:50:33 INFO - Using env: {'DISPLAY': ':0', 19:50:33 INFO - 'HOME': '/home/cltbld', 19:50:33 INFO - 'LANG': 'en_US.UTF-8', 19:50:33 INFO - 'LANGUAGE': 'en_US:en', 19:50:33 INFO - 'LOGNAME': 'cltbld', 19:50:33 INFO - 'MAIL': '/var/mail/cltbld', 19:50:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:50:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 19:50:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:50:33 INFO - 'MOZ_NO_REMOTE': '1', 19:50:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:50:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:50:33 INFO - 'NO_EM_RESTART': '1', 19:50:33 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:50:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:50:33 INFO - 'PWD': '/builds/slave/test-pgo', 19:50:33 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 19:50:33 INFO - 'SHELL': '/bin/bash', 19:50:33 INFO - 'SHLVL': '1', 19:50:33 INFO - 'TERM': 'linux', 19:50:33 INFO - 'TMOUT': '86400', 19:50:33 INFO - 'USER': 'cltbld', 19:50:33 INFO - 'XDG_SESSION_COOKIE': 'd3f2be9b0713ec03b22325b2000001be-1450928065.951739-1081682117', 19:50:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:50:33 INFO - '_': '/tools/buildbot/bin/python'} 19:50:33 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/e77BAwq3TPKhnS84yG9ONQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 19:50:33 INFO - mozversion application_buildid: 20151223173011 19:50:33 INFO - mozversion application_changeset: 1ef0360a8bb223c64972e32f6a0ae3f460add33d 19:50:33 INFO - mozversion application_display_name: Nightly 19:50:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:50:33 INFO - mozversion application_name: Firefox 19:50:33 INFO - mozversion application_remotingname: firefox 19:50:33 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 19:50:33 INFO - mozversion application_vendor: Mozilla 19:50:33 INFO - mozversion application_version: 46.0a1 19:50:33 INFO - mozversion platform_buildid: 20151223173011 19:50:33 INFO - mozversion platform_changeset: 1ef0360a8bb223c64972e32f6a0ae3f460add33d 19:50:33 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 19:50:33 INFO - mozversion platform_version: 46.0a1 19:50:33 INFO - using testdate: 1450929033 19:50:33 INFO - actual date: 1450929033 19:50:33 INFO - starting webserver on 'localhost:34699' 19:50:33 INFO - SUITE-START | Running 3 tests 19:50:33 INFO - TEST-START | dromaeo_css 19:50:33 INFO - operating with platform_type : linux_ 19:50:33 INFO - Initialising browser for dromaeo_css test... 19:50:33 INFO - TEST-INFO | started process 7157 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpHi9D9d/profile http://localhost:34699/getInfo.html) 19:50:37 INFO - PROCESS | 7157 | __metrics Screen width/height:1600/1200 19:50:37 INFO - PROCESS | 7157 | colorDepth:24 19:50:37 INFO - PROCESS | 7157 | Browser inner width/height: 1024/697 19:50:37 INFO - PROCESS | 7157 | __metrics 19:50:37 INFO - PROCESS | 7157 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:50:37 INFO - PROCESS | 7157 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:50:39 INFO - TEST-INFO | 7157: exit 0 19:50:39 INFO - Browser initialized. 19:50:39 INFO - Running cycle 1/1 for dromaeo_css test... 19:50:39 INFO - TEST-INFO | started process 7250 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpHi9D9d/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:50:50 INFO - PROCESS | 7250 | RSS: Main: 149078016 19:50:50 INFO - PROCESS | 7250 | 19:51:41 INFO - PROCESS | 7250 | 1450929101441 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] 19:53:51 INFO - PROCESS | 7250 | Cycle 1(1): loaded http://localhost:34699/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34699/tests/dromaeo/cssquery-ext.html) 19:53:52 INFO - PROCESS | 7250 | RSS: Main: 275144704 19:53:52 INFO - PROCESS | 7250 | 19:56:54 INFO - PROCESS | 7250 | Cycle 1(1): loaded http://localhost:34699/tests/dromaeo/cssquery-ext.html (next: http://localhost:34699/tests/dromaeo/cssquery-jquery.html) 19:56:55 INFO - PROCESS | 7250 | RSS: Main: 235786240 19:56:55 INFO - PROCESS | 7250 | 19:59:57 INFO - PROCESS | 7250 | Cycle 1(1): loaded http://localhost:34699/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34699/tests/dromaeo/cssquery-mootools.html) 19:59:57 INFO - PROCESS | 7250 | RSS: Main: 215191552 19:59:57 INFO - PROCESS | 7250 | 20:02:59 INFO - PROCESS | 7250 | Cycle 1(1): loaded http://localhost:34699/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34699/tests/dromaeo/cssquery-prototype.html) 20:03:00 INFO - PROCESS | 7250 | RSS: Main: 211099648 20:03:00 INFO - PROCESS | 7250 | 20:06:02 INFO - PROCESS | 7250 | Cycle 1(1): loaded http://localhost:34699/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34699/tests/dromaeo/cssquery-yui.html) 20:06:03 INFO - PROCESS | 7250 | RSS: Main: 215244800 20:06:03 INFO - PROCESS | 7250 | 20:09:06 INFO - PROCESS | 7250 | Cycle 1(1): loaded http://localhost:34699/tests/dromaeo/cssquery-yui.html (next: http://localhost:34699/tests/dromaeo/cssquery-dojo.html) 20:09:06 INFO - PROCESS | 7250 | RSS: Main: 256479232 20:09:06 INFO - PROCESS | 7250 | 20:09:06 INFO - PROCESS | 7250 | __start_tp_report 20:09:06 INFO - PROCESS | 7250 | _x_x_mozilla_page_load 20:09:06 INFO - PROCESS | 7250 | _x_x_mozilla_page_load_details 20:09:06 INFO - PROCESS | 7250 | |i|pagename|runs| 20:09:06 INFO - PROCESS | 7250 | |0;dojo.html;3130.2643878688505;3191.585093937788;3230.1924518870296;3233.1917020744813;3256.413845507809;5197.298364720761;5275.419703832576;5362.27609272748;5484.698341591211;5534.557235421162;5295.973520132394;5430.294061771974;5441.183822426638;5483.396826349099;5491.0116179087745;4938.407391113072;4944;4970.527799859007;4991.975040124794;5013.448520662724;4845.709257444564;4980.352554167953;5007.549320561149;5014.348134742479;5064.848054558369;4832.73419961902;4886.877828054292;4905.583025442842;4937.037277730844;4962.627802914778;4900.411950565955;4903.117101937637;4905.901881962376;4935.605151587864;4948.703077815307;4773.5226477352335;4861.611071114302;4886.877828054292;4899.144071347312;4923.18767403378;5230.843074707765;5293.735313234323;5302.098643230622;5303.814366497154;5304.522592966651;5940.495057920039;5945.197398351211;5950.9107363389585;5961.493273071794;5974.581779275452;5792.247007888989;5912.14273930282;5975.372585878464;5994.910076348859;6007.4893634041155;5369.543588794957;5413.052715774724;5413.864653383697;5415.0523658359625;5462.535684466825;6023.789167379121;6127.662978536223;6131.50947924165;6131.785387511505;6138.294096178907;5593.636413633101;5634.492895639412;5685.005124103265;5890.852728681817;5921.585489015728;5714.371419143891;5772.913406298909;5773.24947756789;5790.652560846278;5835.737391817378;5783.421657834183;5835.153902684087;5842.737076831553;5844.240248767718;5847.795327163529;5656.745446454919;5709.429057094258;5754.5971781975695;5838.299404071454;5841.1238314253205;4455.532169122261;4485.641148708096;4488.304312831517;4510.1656193604285;4525.298578720303;3964.980175099106;3975.8012099394914;3981.7810020448574;4003.219372222447;4061.431399604058;5260.13207820713;5339.3058902342445;5355.410904800468;5373.328333958255;5374.167004114369;5746.9712651436475;5806.390329015477;5836.533077353802;5845.1232315153065;5883.911741323884;5367.946320536745;5370.731463426813;5370.865728356823;5376.865578360573;5381.811636592701;4840.29815676732;4941.851744447672;4951.5048495150195;5049.722265275445;5083.085044691991;5939.4357536034;5981.431763982415;5985.880282394328;6051.425114614105;6057.18228039209;5867.911981320369;5870.383609721089;5871.530277577869;5874.882502349844;5876.147958545901;5807.622504537191;5946.762129514944;6025.698715064317;6044.546659000504;6047.365026672136;5758.568107391879;5762.444140082071;5763.538916886555;5813.302403711582;5871.7651293947765;5856.267966504187;5858.033424484912;5860.648361098348;5861.882762344814;5884.529237660891;5594.0769772987005;5722.2561067061015;5724.084146536534;5734.741936612779;5745.052066408995;5693.259876216065;5760.452756988079;5764.827055188351;5771.8557036074435;5813.215215945793;5680.346760122638;5689.601727879009;5694.202811606296;5697.373288938296;5700.800471983626;5520.503154716095;5652.773889044557;5697.515711164598;5735.4551317624755;5774.364819869895;5512.980098681756;5517.668939863621;5523.944760552343;5527.419620939904;5560.777568897199 20:09:06 INFO - PROCESS | 7250 | |1;ext.html;552.6131707804535;597.5846786483396;606.3269770554683;613.9293981192164;614.1892701633843;29852.701472985264;30624;39491.21017579647;40232.59767402325;40273;43707;44571.77714111433;44624.107517849705;44657;44719.55280447195;7618.1620021797835;8787.604557794915;8957.507337096456;8971.820563588724;8975.326850486206;7746.49647772893;7848;7849.411294152933;10443.321184123046;10719.142468602533;10441;10538;10546.419946902917;10547.789044219111;10549;10429.895701043006;10546.578136874516;10553.683389498327;10565.524551395129;10568.999999999962;7817.218278172194;8027;10247.282690211689;10440.63457778974;10447.79104417915;38343.42484862729;38400.807995960124;38500.614993850264;38651.61348386508;38664;3371.4100032494216;3632.4551317302617;3885.9896426928917;3944.4280579315837;4032.354823228269;30974.519624079538;31452.842735786402;31481.37037259242;31677.841610792027;32199.195020124684;3939.310620641405;3947.1513624570566;3976.3439032559595;4022.8994275143064;4075.6331930126134;285782;286473;286595;287210;287428;53113.2033019505;62286.68856655688;62642;62837.37162628407;62867.37132628615;53249.2012619811;70758;72180.63909680418;72429;72654.54690906152;14742.484013059491;14829.925850370895;14911.179885106423;14935.477258296125;14937.551873443814;11140;11202.103831693445;11217.149170386958;11225.270357426905;11231.326120432801;20208.797912020986;20302;20340.593188136154;20372.89813550923;20546.28088016912;7634.6946122155605;7857.607119643995;7861.882071768928;7867.173946735625;7972.681092756225;935.8830146231721;1001.4441984698562;1003.844404117363;1015.263933648114;1045.6235755128148;28774.712252877624;29036.41927161445;29080.418391632047;29128.417431651247;29343.413131737674;1029.264076185516;1034.813733527972;1048.171944164102;1073.431081526792;1079.5681727309138;13570.321483925763;13681.11072780286;13696.315184240748;13773.173609583257;13877;247351;250538;251118;251310;251595;47686;47722.76138619285;47785.5221447788;47932.28101578479;48025;1332.6401871494836;1351.4999450203488;1354.4920654754467;1355.3494322725146;1359.5989183190982;23512;33800.66199338074;34922;35291.29417411586;35316;48398.75800620974;49199.75400122976;49236.50763492462;49257.75371123121;49343.506564933894;227429;229676;229792;230507.84746076833;231148;34815.65184348124;38459.6154038456;42258.78870605627;43274.78362608167;49169.754151230445;46813.76593117149;46854.29718554293;47913;48098.27852582284;48133.27800082931;39402.40896386614;39523.80238098791;40752.59247407488;41587.7920610395;42178.836587255464;39924.35635898044;40723.796381017906;41137.58862411338;43636.78181609072;43906.780466097465;39347;39807.80096099501;39850.20299593934;40062.599374007055;40404.79797600993;35495.64504355027;35852.64147358597;36218.81890590636;36230.63769362378;36641.81679091587;26713.465730685668;27464.15101849987;27538.449231014867;27653.861730692024;27709.861450692617 20:09:06 INFO - PROCESS | 7250 | |2;jquery.html;352.7846568571271;356.9411047177216;357.7370632585051;358.85825099085855;361.5408431292259;14181.78727319091;14514.709705805877;15777.526674199778;16014;16694.415695450647;16137.354505819752;16529.173541322947;17094.145292735375;17377.391791287308;17428.82571174288;5416.133418653026;5555.8888822223735;5556.361018482886;5564.10974244121;5564.527015203692;4026.557078721353;4128.050548373876;5460.044492213847;5928.6739229342365;6031;5975.701214939258;5988.580799344048;5994.220751302325;6012.278526576817;6024.096385542181;5965.46310832025;6122.510199184055;6122.846928826771;6127.632342059491;6129.356417576158;5301.310829592167;5371;5381.192821076831;5404;5404.162354835007;20892.582148357098;20893.791062089487;21044.5791084179;21286.680699789515;21338.146474141016;2233.7431195412573;2245.2478419729246;2341.7775311345395;2364.680768096302;2392.808575313971;13023.869761302456;13030.80453793194;13059.934700326532;13125.737485250336;13555.932220338935;1785.874988750775;1808.9909550452296;1858.8884666920028;1868.1914771850788;1873.72830939513;58696.41303586952;61170;61987;62202;62351.376486235466;9640.276979226586;9851.113399794052;10007.349522281029;10022.3485473444;10084.092431681183;13018.544350947672;13060.21638701681;13067.215967042008;13074.869251307555;13091.214527128403;7237.421006319481;7257.310555497219;7299.160596531467;7303.59830209333;7398.519096258834;6849.075374824434;6856.211535673362;6890.2420733719255;6908.792736217922;6909.032735417046;5888.735006924699;5903.527717782567;5950.137230101697;5978.744463662592;6037.486813620803;1680.7142785726212;1732.0727969731115;1755.5523341547823;1788.2578729827237;1792.8834625749284;903.0969030969031;931.5481991234246;958.6213445688913;986.8667729856521;1098.7033500954697;16973.49079527616;17282.65434691299;17464.738028929576;17476.650466990588;17594.73607895857;980.2745967983783;985.7387792235063;992.9007099290013;1007.7682133109425;1050.6952983634812;9638.95180524093;10070.44612546317;10171.694849154537;10188.643397481053;10203.489825508843;539466;546359;548048;559755;563126;80082.19917800747;80995;81294.59352703199;81619.18380816234;82291.17708822835;1154.751728378386;1161.4715304536585;1165.1669056624723;1173.4895320535595;1181.5037684172669;15518.767218491506;15605.921970390076;15780.92109539445;15823.841761582697;15901.840981590498;34668.306633866676;35379.115522111126;35944.64055359413;35987.46018809772;36185.27629447449;46211.537884620724;46557.30164047474;46747.29879051749;47598.52401475941;50889.745551272004;9315.25477961775;9321.741564888924;9397.449420845483;9415.482148481899;9438.103380178873;11523.711907202387;11718.121140914294;11748.060155187393;11755.588554400554;13734.519291824738;11813.468393922121;13012.28432436225;14122.646933826325;14332.785008224677;14354.3540540678;13538.390772415069;13997.020208585709;14117.505887293895;14284.785728213878;14309.785353219502;14524.273786310854;14592.854071459575;14691.485797997018;15323.157226352212;15343;9128;9142.131497507726;9405.43567385959;9427.245820334494;9440.527973601429;10062.39625622465;12641.93679031599;14690.485832995793;15002.924985375003;15213.467528636445 20:09:06 INFO - PROCESS | 7250 | |3;mootools.html;1516.0221657031223;1669.9165041747913;1726.5079452356076;1731.904745239012;1756.587202007528;6599.439047680947;7185.784426467208;7368.373688236493;7382.040334756474;7390.630468476568;7286.453515986309;7439.628018599075;7449.180590135081;7455.850882982337;7466.440016998733;1929.0644037641803;1964.6836619464993;1972.5463143476936;2210.35899589119;2254.7068881045443;1933.4393026022437;2220.9222677206303;2265.105283413051;2267.5691618592414;2269.375921621559;2156.568686262746;2164.166795783619;2192.199847055829;2196.8352373571965;2228.1310288987306;2207.845450818443;2222.822174226058;2235.3629215673536;2236.8546044507057;2239.1379318962154;2197.8681279123302;2246.056656204398;2246.067881829039;2246.326102169359;2246.5506898620342;7125.893111603278;7153;7177.9282207177785;7184;7184.640767961633;4431.822727090913;4501.887452813706;4507.211238033331;4508.842190523349;4545.749983750892;3084.506478963355;3090.088423914928;3122.703343182394;3128.358686469291;3136.702013308732;1061.2836335473523;1086.5708045322133;1103.8840921703186;1137.8634563852308;1145.6333973128603;9833.606655733834;9880.160186384166;9889.109980101754;9982.351147175483;9986.700398987969;4027.8791636250958;4056.492938382702;4095.713300069026;4098.364753463218;4109.465769449952;8786.956065219762;8808.91191088081;8811.383203175845;8820.691275805317;8822.470651760786;4522.615577675869;4530.22986092365;4532.9773351133035;4566.95433045672;4571.245744452194;4113.239050775616;4129.669626429878;4151.647109995623;4157.10622216225;4166.937495937564;3295.5880514935634;3434.862605495802;3446.3451944130534;3459.3081383723356;3481.912952176165;1061.9575216991234;1075.4353964168874;1146.60442147459;1156.7166044319197;1165.6561314412268;976.077606661712;976.2531663277598;980.1864452504404;1048.182417714184;1197.203859433467;6557.868842623217;6629.138212032405;6636.767713130113;6645.269020407752;6649.501287403367;582.2779753106117;586.0067186119571;590.9704514774244;593.0659211741524;741.1476801678006;5028.472010438924;5121.718305493234;5122.846314610568;5123.103456895028;5127.051495473349;8620.78448038804;8746;8872.689455869013;8902.332325075646;8980.191782739585;8757.430767000125;8832.779180520538;8837;8862.246709029805;8887.511186884783;6719.160104986779;7012.333828286304;7060.470464715167;7086.149662040485;7089.184743754534;6635.701393437211;6702.095217145623;6705.430038446787;6706.631135287606;6711.228208755861;7905.723299684483;8116.878246826421;8138.470999385021;8145.348372130334;8148.1037085919315;8153.959230203811;8198.344132469269;8317.95841020791;8334.541600212047;8355.623996920032;6389.55273130895;6411;6458.54790164684;6467.094606755152;6485;6417.069524918954;6460.967695161494;6930.3762661360715;7027.332403421667;7029.3673569379;6576.342365763386;6607.273199948098;6673.933260667525;6742.190937087581;6877.1747390313485;6386.904196436964;6592.143021407186;6665.600063995982;6706.731730730716;6757.662116894037;6586.242582103119;6605.174353205849;6617.867642647217;6648.301928297459;6649.035889795856;5887.882242355215;5909.793157239476;5921.555883308855;5922.052471604523;5924.911126333022;5973.313068997121;6043.969780151071;6049.092636104443;6053.60651557665;6114.7554097837365 20:09:06 INFO - PROCESS | 7250 | |4;prototype.html;318.17116411747395;323.6375259709125;328.2368493253187;331.6948407465132;331.87720543398933;5923.348431672518;5927.644341339517;5967.045272756354;5986.2517185351835;6024.1566180734735;5873.970630146854;5879.52963762899;5890.970545147268;5892;5894.056950887859;4554.157480866033;4558.361829343895;4561.087782443508;4566.018306064196;4566.931496027562;4387.7367357958465;4537.047220083787;4542.772861356935;4562.292844609091;4566;4475.440569928759;4493.573110554508;4494.640428765691;4499.955000449986;4503.662225333097;4272.401863739079;4443.333499975013;4457.531959144292;4484.730916145042;4501.504834468205;3784.6026167252317;3826.3112639724836;3898.8440462381473;3905.1408690088133;3910.1006768443135;5604.719764011783;5614.6631202128;5634.5210657093785;5647.040003199466;5654.067078931971;4971.055499455092;5056.924146137811;5101.489851014906;5194.0910340690225;5216.061109000379;6190.721417536221;6248.187735594389;6253.562250642457;6258.84211420884;6262.342454042351;4309.741415515079;4313.202057619351;4319.02821865081;4319.69762116652;4322.589354011364;6360.300366959677;6433.292337842833;6486.610803351814;6505.804825855232;6522.836929076763;4376.256036473807;4387.605115539617;4415.955840441618;4444.933326000112;4448.755318457451;4500.437445319335;4501.257292546758;4502.167099086614;4506.639468842484;4508.413906192174;5220.190870415092;5224.824414506706;5229.450907654642;5233.895322093613;5233.921491177635;6120.479759220516;6302.65335406557;6328.873422531524;6335.303116657164;6343.365663433619;1554.2461905975592;1585.722498562747;1587.9995602770412;1589.1418633937776;1590.514892957659;1053.5733028123623;1057.3655806516028;1058.3808472043786;1066.168388656849;1072.8605281313535;5980.312264089685;5984.012637914695;5993.0710739835395;5994.940050599438;5998.340182579913;6449.161608990801;6502.317256687979;6518.869622607522;6519.934800652028;6524.771632992823;5985.670788106609;5986.431289027535;5990.460858522754;5993.820185394445;5993.970030149909;3451.137215696076;3504.404251277289;3523.3129539739502;3533.611302756695;3537.5931767846514;6719.865602687919;6754.3921047106;6756.087928129639;6768.72925083001;6778.898316525256;6448.580842245239;6758.763443279461;6762.459003279726;6762.932370676329;6767.830804229835;6244.0321750128805;6557.868842623121;6716.496262780213;6755.155605549405;6761.8647627047185;6530.738770449128;6532.346765323429;6539.607623542603;6546.770863019771;6551.50863685216;6491.188601424822;6491.253505846888;6495.512836537184;6498.252700939453;6507.219133703986;6597.0764093026055;6710.83222919431;6717.093192418961;6728.259891411843;6730.125083739083;4385.320275357325;4436.5119836817275;4442.200403927324;4443.511213766547;4443.688941774045;6545.476361890942;6566.606003639797;6572.80281591553;6575.53971222029;6576.079348891255;6257.2804127525915;6397.584157029778;6400.9039864403;6403.07155462446;6403.423691867754;6331.936680633319;6376.4580010697755;6377.7767778127545;6387.457066149429;6394.776182833579;6273.059041143682;6274.090256912813;6274.309825919237;6274.780382686584;6279.811605651837;6262.2172228471445;6424.164858568356;6455.2576453708425;6458.935410645833;6459.739091318189;6288.5598008138995;6291.402316779899;6298.370162983665;6302.9684851577285;6303.905441418291 20:09:06 INFO - PROCESS | 7250 | |5;yui.html;749.3817600479603;768.1627026541073;825.5872063968015;872.8647059705739;876.1763941894619;14214.502492412756;14370.209638469893;14387.496437624684;14472.493462728806;14502.41990320386;12290.877091229086;12380.628581142557;12389.442475088621;12405.875941240585;12408.06939479538;689.035350509286;692.6259819697358;819.1644522586957;835.5028757889046;837.798928257217;829.784256093414;831.8336332733447;832.1553623072587;836.5775283481834;839.0518713853337;894.1639567004871;896.2964073202537;898.1018981018981;898.27239935652;898.5776684958059;731.7292601737338;733.8899165125221;873.5021038008338;882.0473888200792;884.3986089459165;648.5330561995356;651.6741629185407;652.341135453191;652.5464801962638;652.8106849013781;13826.377812998438;13978.370973306226;13988.230647314394;13996.93001534996;13997.3701183447;12085.758284834343;12514.1865778725;12614.495420183273;12799.19249257952;12824.743505129845;10250.282480226388;10348.430836304;10427.79144417115;10552.472376381227;10959.945200274027;3614.7469677122613;3663.0292972362345;3671.522702048743;3736.663700266989;3739.7943113128767;46553.30170047452;46645.533544664795;46783.76608116938;46867.062658746974;47092.99999999966;9975.850362244571;10257.435841028815;10305.690829275134;10638.946805265925;10939.945300273606;18957.52606184829;19023.809761902205;19041;19056.428307150807;19057.428277151706;7544.735934242275;7633.809154771176;7662.5785581792425;7766.805829854299;8123.47197432165;4222.4299719538085;4237;4239.427677263591;4252.787360631956;4329.437173167531;2984.805987610842;3017.834019128925;3018.6679465258803;3020.4865172920654;3020.7130322619314;505.5172310443591;518.072649956581;522.0524747583124;557.5010365722736;557.8884223155385;587.9147523609053;678.633537889544;680.9591424514545;698.3191388396375;716.3767522255566;8134.59327033646;8829.823403532022;9157.771055723528;9165;9574.617015319309;530.3079481276893;638.9872202555923;660.6828722213364;664.9268580456146;716.9498135130491;3925.4111883217747;3998.9400158997637;4187.539370669224;4398.626116780109;4415.911681766347;55391.44608553863;58521.414785852445;59060.70469647624;59125.52186195293;59163.70418147882;52503;54021.72989135029;54220.45779542154;54277.72861135748;54304.99999999921;46486;46960.7651961738;47787.522124779;49120.2631960528;49212.26181607279;8433.95783021081;8478.3641226907;8609.91390086091;8809.42738721981;9077.45535267886;34702.30595388129;36139.81930090438;36508.452373214954;37076.25847482981;37107;44755.55244447644;44974;45207.54792452033;46034.30948535708;47599.52400475951;11122.777544449227;11144.49849756779;11401.315921044765;11430.314181149157;11848.407579621156;12191.756164876475;12682.936585317015;12684.048696347996;13022.934885325512;13025.218486890817;11012.39431831225;11422.25755325901;11768.94115529417;12086.697832554257;12274.140810143204;11991.460384282555;12201.755964880831;12358.567450139202;12408.379581021094;12437.751244974868;8400.285975692135;10039.4478303694;10622.150227981589;12082.214656047328;12161.513539458323;9727;9914.454704991007;9963.651272205438;10522.789544209227;10655.20085993569;9391.483468409304;9423.963364030089;9839.754006149617;10143.89856101459;10186.898131018595 20:09:06 INFO - PROCESS | 7250 | __end_tp_report 20:09:06 INFO - PROCESS | 7250 | __start_cc_report 20:09:06 INFO - PROCESS | 7250 | _x_x_mozilla_cycle_collect,1009 20:09:06 INFO - PROCESS | 7250 | __end_cc_report 20:09:06 INFO - PROCESS | 7250 | __startTimestamp1450930146522__endTimestamp 20:09:06 INFO - PROCESS | 7250 | 20:09:06 INFO - PROCESS | 7250 | ------- Summary: start ------- 20:09:06 INFO - PROCESS | 7250 | Number of tests: 6 20:09:06 INFO - PROCESS | 7250 | 20:09:06 INFO - PROCESS | 7250 | [#0] dojo.html Cycles:165 Average:5404.31 Median:5594.08 stddev:618.86 (11.1%) stddev-sans-first:594.49 20:09:06 INFO - PROCESS | 7250 | Values: 3130.3 3191.6 3230.2 3233.2 3256.4 5197.3 5275.4 5362.3 5484.7 5534.6 5296.0 5430.3 5441.2 5483.4 5491.0 4938.4 4944.0 4970.5 4992.0 5013.4 4845.7 4980.4 5007.5 5014.3 5064.8 4832.7 4886.9 4905.6 4937.0 4962.6 4900.4 4903.1 4905.9 4935.6 4948.7 4773.5 4861.6 4886.9 4899.1 4923.2 5230.8 5293.7 5302.1 5303.8 5304.5 5940.5 5945.2 5950.9 5961.5 5974.6 5792.2 5912.1 5975.4 5994.9 6007.5 5369.5 5413.1 5413.9 5415.1 5462.5 6023.8 6127.7 6131.5 6131.8 6138.3 5593.6 5634.5 5685.0 5890.9 5921.6 5714.4 5772.9 5773.2 5790.7 5835.7 5783.4 5835.2 5842.7 5844.2 5847.8 5656.7 5709.4 5754.6 5838.3 5841.1 4455.5 4485.6 4488.3 4510.2 4525.3 3965.0 3975.8 3981.8 4003.2 4061.4 5260.1 5339.3 5355.4 5373.3 5374.2 5747.0 5806.4 5836.5 5845.1 5883.9 5367.9 5370.7 5370.9 5376.9 5381.8 4840.3 4941.9 4951.5 5049.7 5083.1 5939.4 5981.4 5985.9 6051.4 6057.2 5867.9 5870.4 5871.5 5874.9 5876.1 5807.6 5946.8 6025.7 6044.5 6047.4 5758.6 5762.4 5763.5 5813.3 5871.8 5856.3 5858.0 5860.6 5861.9 5884.5 5594.1 5722.3 5724.1 5734.7 5745.1 5693.3 5760.5 5764.8 5771.9 5813.2 5680.3 5689.6 5694.2 5697.4 5700.8 5520.5 5652.8 5697.5 5735.5 5774.4 5513.0 5517.7 5523.9 5527.4 5560.8 20:09:06 INFO - PROCESS | 7250 | 20:09:06 INFO - PROCESS | 7250 | [#1] ext.html Cycles:180 Average:44663.18 Median:36224.73 stddev:66697.65 (184.1%) stddev-sans-first:66802.52 20:09:06 INFO - PROCESS | 7250 | Values: 552.6 597.6 606.3 613.9 614.2 29852.7 30624.0 39491.2 40232.6 40273.0 43707.0 44571.8 44624.1 44657.0 44719.6 7618.2 8787.6 8957.5 8971.8 8975.3 7746.5 7848.0 7849.4 10443.3 10719.1 10441.0 10538.0 10546.4 10547.8 10549.0 10429.9 10546.6 10553.7 10565.5 10569.0 7817.2 8027.0 10247.3 10440.6 10447.8 38343.4 38400.8 38500.6 38651.6 38664.0 3371.4 3632.5 3886.0 3944.4 4032.4 30974.5 31452.8 31481.4 31677.8 32199.2 3939.3 3947.2 3976.3 4022.9 4075.6 285782.0 286473.0 286595.0 287210.0 287428.0 53113.2 62286.7 62642.0 62837.4 62867.4 53249.2 70758.0 72180.6 72429.0 72654.5 14742.5 14829.9 14911.2 14935.5 14937.6 11140.0 11202.1 11217.1 11225.3 11231.3 20208.8 20302.0 20340.6 20372.9 20546.3 7634.7 7857.6 7861.9 7867.2 7972.7 935.9 1001.4 1003.8 1015.3 1045.6 28774.7 29036.4 29080.4 29128.4 29343.4 1029.3 1034.8 1048.2 1073.4 1079.6 13570.3 13681.1 13696.3 13773.2 13877.0 247351.0 250538.0 251118.0 251310.0 251595.0 47686.0 47722.8 47785.5 47932.3 48025.0 1332.6 1351.5 1354.5 1355.3 1359.6 23512.0 33800.7 34922.0 35291.3 35316.0 48398.8 49199.8 49236.5 49257.8 49343.5 227429.0 229676.0 229792.0 230507.8 231148.0 34815.7 38459.6 42258.8 43274.8 49169.8 46813.8 46854.3 47913.0 48098.3 48133.3 39402.4 39523.8 40752.6 41587.8 42178.8 39924.4 40723.8 41137.6 43636.8 43906.8 39347.0 39807.8 39850.2 40062.6 40404.8 35495.6 35852.6 36218.8 36230.6 36641.8 26713.5 27464.2 27538.4 27653.9 27709.9 20:09:06 INFO - PROCESS | 7250 | 20:09:06 INFO - PROCESS | 7250 | [#2] jquery.html Cycles:180 Average:29285.42 Median:17510.55 stddev:90092.18 (514.5%) stddev-sans-first:90318.71 20:09:06 INFO - PROCESS | 7250 | Values: 352.8 356.9 357.7 358.9 361.5 14181.8 14514.7 15777.5 16014.0 16694.4 16137.4 16529.2 17094.1 17377.4 17428.8 5416.1 5555.9 5556.4 5564.1 5564.5 4026.6 4128.1 5460.0 5928.7 6031.0 5975.7 5988.6 5994.2 6012.3 6024.1 5965.5 6122.5 6122.8 6127.6 6129.4 5301.3 5371.0 5381.2 5404.0 5404.2 20892.6 20893.8 21044.6 21286.7 21338.1 2233.7 2245.2 2341.8 2364.7 2392.8 13023.9 13030.8 13059.9 13125.7 13555.9 1785.9 1809.0 1858.9 1868.2 1873.7 58696.4 61170.0 61987.0 62202.0 62351.4 9640.3 9851.1 10007.3 10022.3 10084.1 13018.5 13060.2 13067.2 13074.9 13091.2 7237.4 7257.3 7299.2 7303.6 7398.5 6849.1 6856.2 6890.2 6908.8 6909.0 5888.7 5903.5 5950.1 5978.7 6037.5 1680.7 1732.1 1755.6 1788.3 1792.9 903.1 931.5 958.6 986.9 1098.7 16973.5 17282.7 17464.7 17476.7 17594.7 980.3 985.7 992.9 1007.8 1050.7 9639.0 10070.4 10171.7 10188.6 10203.5 539466.0 546359.0 548048.0 559755.0 563126.0 80082.2 80995.0 81294.6 81619.2 82291.2 1154.8 1161.5 1165.2 1173.5 1181.5 15518.8 15605.9 15780.9 15823.8 15901.8 34668.3 35379.1 35944.6 35987.5 36185.3 46211.5 46557.3 46747.3 47598.5 50889.7 9315.3 9321.7 9397.4 9415.5 9438.1 11523.7 11718.1 11748.1 11755.6 13734.5 11813.5 13012.3 14122.6 14332.8 14354.4 13538.4 13997.0 14117.5 14284.8 14309.8 14524.3 14592.9 14691.5 15323.2 15343.0 9128.0 9142.1 9405.4 9427.2 9440.5 10062.4 12641.9 14690.5 15002.9 15213.5 20:09:06 INFO - PROCESS | 7250 | 20:09:06 INFO - PROCESS | 7250 | [#3] mootools.html Cycles:180 Average:5147.76 Median:6250.83 stddev:2652.32 (42.4%) stddev-sans-first:2645.71 20:09:06 INFO - PROCESS | 7250 | Values: 1516.0 1669.9 1726.5 1731.9 1756.6 6599.4 7185.8 7368.4 7382.0 7390.6 7286.5 7439.6 7449.2 7455.9 7466.4 1929.1 1964.7 1972.5 2210.4 2254.7 1933.4 2220.9 2265.1 2267.6 2269.4 2156.6 2164.2 2192.2 2196.8 2228.1 2207.8 2222.8 2235.4 2236.9 2239.1 2197.9 2246.1 2246.1 2246.3 2246.6 7125.9 7153.0 7177.9 7184.0 7184.6 4431.8 4501.9 4507.2 4508.8 4545.7 3084.5 3090.1 3122.7 3128.4 3136.7 1061.3 1086.6 1103.9 1137.9 1145.6 9833.6 9880.2 9889.1 9982.4 9986.7 4027.9 4056.5 4095.7 4098.4 4109.5 8787.0 8808.9 8811.4 8820.7 8822.5 4522.6 4530.2 4533.0 4567.0 4571.2 4113.2 4129.7 4151.6 4157.1 4166.9 3295.6 3434.9 3446.3 3459.3 3481.9 1062.0 1075.4 1146.6 1156.7 1165.7 976.1 976.3 980.2 1048.2 1197.2 6557.9 6629.1 6636.8 6645.3 6649.5 582.3 586.0 591.0 593.1 741.1 5028.5 5121.7 5122.8 5123.1 5127.1 8620.8 8746.0 8872.7 8902.3 8980.2 8757.4 8832.8 8837.0 8862.2 8887.5 6719.2 7012.3 7060.5 7086.1 7089.2 6635.7 6702.1 6705.4 6706.6 6711.2 7905.7 8116.9 8138.5 8145.3 8148.1 8154.0 8198.3 8318.0 8334.5 8355.6 6389.6 6411.0 6458.5 6467.1 6485.0 6417.1 6461.0 6930.4 7027.3 7029.4 6576.3 6607.3 6673.9 6742.2 6877.2 6386.9 6592.1 6665.6 6706.7 6757.7 6586.2 6605.2 6617.9 6648.3 6649.0 5887.9 5909.8 5921.6 5922.1 5924.9 5973.3 6044.0 6049.1 6053.6 6114.8 20:09:06 INFO - PROCESS | 7250 | 20:09:06 INFO - PROCESS | 7250 | [#4] prototype.html Cycles:180 Average:5261.21 Median:5985.96 stddev:1602.08 (26.8%) stddev-sans-first:1563.03 20:09:06 INFO - PROCESS | 7250 | Values: 318.2 323.6 328.2 331.7 331.9 5923.3 5927.6 5967.0 5986.3 6024.2 5874.0 5879.5 5891.0 5892.0 5894.1 4554.2 4558.4 4561.1 4566.0 4566.9 4387.7 4537.0 4542.8 4562.3 4566.0 4475.4 4493.6 4494.6 4500.0 4503.7 4272.4 4443.3 4457.5 4484.7 4501.5 3784.6 3826.3 3898.8 3905.1 3910.1 5604.7 5614.7 5634.5 5647.0 5654.1 4971.1 5056.9 5101.5 5194.1 5216.1 6190.7 6248.2 6253.6 6258.8 6262.3 4309.7 4313.2 4319.0 4319.7 4322.6 6360.3 6433.3 6486.6 6505.8 6522.8 4376.3 4387.6 4416.0 4444.9 4448.8 4500.4 4501.3 4502.2 4506.6 4508.4 5220.2 5224.8 5229.5 5233.9 5233.9 6120.5 6302.7 6328.9 6335.3 6343.4 1554.2 1585.7 1588.0 1589.1 1590.5 1053.6 1057.4 1058.4 1066.2 1072.9 5980.3 5984.0 5993.1 5994.9 5998.3 6449.2 6502.3 6518.9 6519.9 6524.8 5985.7 5986.4 5990.5 5993.8 5994.0 3451.1 3504.4 3523.3 3533.6 3537.6 6719.9 6754.4 6756.1 6768.7 6778.9 6448.6 6758.8 6762.5 6762.9 6767.8 6244.0 6557.9 6716.5 6755.2 6761.9 6530.7 6532.3 6539.6 6546.8 6551.5 6491.2 6491.3 6495.5 6498.3 6507.2 6597.1 6710.8 6717.1 6728.3 6730.1 4385.3 4436.5 4442.2 4443.5 4443.7 6545.5 6566.6 6572.8 6575.5 6576.1 6257.3 6397.6 6400.9 6403.1 6403.4 6331.9 6376.5 6377.8 6387.5 6394.8 6273.1 6274.1 6274.3 6274.8 6279.8 6262.2 6424.2 6455.3 6458.9 6459.7 6288.6 6291.4 6298.4 6303.0 6303.9 20:09:06 INFO - PROCESS | 7250 | 20:09:06 INFO - PROCESS | 7250 | [#5] yui.html Cycles:180 Average:14110.86 Median:46260.15 stddev:16284.83 (35.2%) stddev-sans-first:16299.60 20:09:06 INFO - PROCESS | 7250 | Values: 749.4 768.2 825.6 872.9 876.2 14214.5 14370.2 14387.5 14472.5 14502.4 12290.9 12380.6 12389.4 12405.9 12408.1 689.0 692.6 819.2 835.5 837.8 829.8 831.8 832.2 836.6 839.1 894.2 896.3 898.1 898.3 898.6 731.7 733.9 873.5 882.0 884.4 648.5 651.7 652.3 652.5 652.8 13826.4 13978.4 13988.2 13996.9 13997.4 12085.8 12514.2 12614.5 12799.2 12824.7 10250.3 10348.4 10427.8 10552.5 10959.9 3614.7 3663.0 3671.5 3736.7 3739.8 46553.3 46645.5 46783.8 46867.1 47093.0 9975.9 10257.4 10305.7 10638.9 10939.9 18957.5 19023.8 19041.0 19056.4 19057.4 7544.7 7633.8 7662.6 7766.8 8123.5 4222.4 4237.0 4239.4 4252.8 4329.4 2984.8 3017.8 3018.7 3020.5 3020.7 505.5 518.1 522.1 557.5 557.9 587.9 678.6 681.0 698.3 716.4 8134.6 8829.8 9157.8 9165.0 9574.6 530.3 639.0 660.7 664.9 716.9 3925.4 3998.9 4187.5 4398.6 4415.9 55391.4 58521.4 59060.7 59125.5 59163.7 52503.0 54021.7 54220.5 54277.7 54305.0 46486.0 46960.8 47787.5 49120.3 49212.3 8434.0 8478.4 8609.9 8809.4 9077.5 34702.3 36139.8 36508.5 37076.3 37107.0 44755.6 44974.0 45207.5 46034.3 47599.5 11122.8 11144.5 11401.3 11430.3 11848.4 12191.8 12682.9 12684.0 13022.9 13025.2 11012.4 11422.3 11768.9 12086.7 12274.1 11991.5 12201.8 12358.6 12408.4 12437.8 8400.3 10039.4 10622.2 12082.2 12161.5 9727.0 9914.5 9963.7 10522.8 10655.2 9391.5 9424.0 9839.8 10143.9 10186.9 20:09:06 INFO - PROCESS | 7250 | -------- Summary: end -------- 20:09:06 INFO - PROCESS | 7250 | 20:09:07 INFO - TEST-INFO | 7250: exit 0 20:09:07 INFO - TEST-OK | dromaeo_css | took 1113553ms 20:09:07 INFO - TEST-START | kraken 20:09:07 INFO - operating with platform_type : linux_ 20:09:07 INFO - Initialising browser for kraken test... 20:09:07 INFO - TEST-INFO | started process 7437 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpt4rdRr/profile http://localhost:34699/getInfo.html) 20:09:11 INFO - PROCESS | 7437 | __metrics Screen width/height:1600/1200 20:09:11 INFO - PROCESS | 7437 | colorDepth:24 20:09:11 INFO - PROCESS | 7437 | Browser inner width/height: 1024/697 20:09:11 INFO - PROCESS | 7437 | __metrics 20:09:11 INFO - PROCESS | 7437 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 20:09:11 INFO - PROCESS | 7437 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:09:12 INFO - TEST-INFO | 7437: exit 0 20:09:12 INFO - Browser initialized. 20:09:12 INFO - Running cycle 1/1 for kraken test... 20:09:12 INFO - TEST-INFO | started process 7521 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpt4rdRr/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:09:23 INFO - PROCESS | 7521 | RSS: Main: 148717568 20:09:23 INFO - PROCESS | 7521 | 20:09:26 INFO - PROCESS | 7521 | Cycle 1(1): loaded http://localhost:34699/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34699/tests/kraken/driver.html?testName=audio-beat-detection) 20:09:26 INFO - PROCESS | 7521 | RSS: Main: 184291328 20:09:26 INFO - PROCESS | 7521 | 20:09:29 INFO - PROCESS | 7521 | Cycle 1(1): loaded http://localhost:34699/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34699/tests/kraken/driver.html?testName=audio-dft) 20:09:30 INFO - PROCESS | 7521 | RSS: Main: 174006272 20:09:30 INFO - PROCESS | 7521 | 20:09:32 INFO - PROCESS | 7521 | Cycle 1(1): loaded http://localhost:34699/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34699/tests/kraken/driver.html?testName=audio-fft) 20:09:33 INFO - PROCESS | 7521 | RSS: Main: 160657408 20:09:33 INFO - PROCESS | 7521 | 20:09:35 INFO - PROCESS | 7521 | Cycle 1(1): loaded http://localhost:34699/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34699/tests/kraken/driver.html?testName=audio-oscillator) 20:09:36 INFO - PROCESS | 7521 | RSS: Main: 164601856 20:09:36 INFO - PROCESS | 7521 | 20:09:38 INFO - PROCESS | 7521 | Cycle 1(1): loaded http://localhost:34699/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34699/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:09:38 INFO - PROCESS | 7521 | RSS: Main: 166277120 20:09:38 INFO - PROCESS | 7521 | 20:09:41 INFO - PROCESS | 7521 | Cycle 1(1): loaded http://localhost:34699/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34699/tests/kraken/driver.html?testName=imaging-darkroom) 20:09:42 INFO - PROCESS | 7521 | RSS: Main: 164253696 20:09:42 INFO - PROCESS | 7521 | 20:09:45 INFO - PROCESS | 7521 | Cycle 1(1): loaded http://localhost:34699/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34699/tests/kraken/driver.html?testName=imaging-desaturate) 20:09:46 INFO - PROCESS | 7521 | RSS: Main: 166350848 20:09:46 INFO - PROCESS | 7521 | 20:09:49 INFO - PROCESS | 7521 | Cycle 1(1): loaded http://localhost:34699/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34699/tests/kraken/driver.html?testName=json-parse-financial) 20:09:49 INFO - PROCESS | 7521 | RSS: Main: 165015552 20:09:49 INFO - PROCESS | 7521 | 20:09:51 INFO - PROCESS | 7521 | Cycle 1(1): loaded http://localhost:34699/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34699/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:09:51 INFO - PROCESS | 7521 | RSS: Main: 177549312 20:09:51 INFO - PROCESS | 7521 | 20:09:53 INFO - PROCESS | 7521 | Cycle 1(1): loaded http://localhost:34699/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34699/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:09:54 INFO - PROCESS | 7521 | RSS: Main: 174424064 20:09:54 INFO - PROCESS | 7521 | 20:09:56 INFO - PROCESS | 7521 | Cycle 1(1): loaded http://localhost:34699/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34699/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:09:56 INFO - PROCESS | 7521 | RSS: Main: 183783424 20:09:56 INFO - PROCESS | 7521 | 20:09:59 INFO - PROCESS | 7521 | Cycle 1(1): loaded http://localhost:34699/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34699/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:09:59 INFO - PROCESS | 7521 | RSS: Main: 191827968 20:09:59 INFO - PROCESS | 7521 | 20:10:02 INFO - PROCESS | 7521 | Cycle 1(1): loaded http://localhost:34699/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34699/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:10:02 INFO - PROCESS | 7521 | RSS: Main: 189685760 20:10:02 INFO - PROCESS | 7521 | 20:10:04 INFO - PROCESS | 7521 | Cycle 1(1): loaded http://localhost:34699/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34699/tests/kraken/driver.html?testName=ai-astar) 20:10:04 INFO - PROCESS | 7521 | RSS: Main: 246673408 20:10:04 INFO - PROCESS | 7521 | 20:10:04 INFO - PROCESS | 7521 | __start_tp_report 20:10:04 INFO - PROCESS | 7521 | _x_x_mozilla_page_load 20:10:04 INFO - PROCESS | 7521 | _x_x_mozilla_page_load_details 20:10:04 INFO - PROCESS | 7521 | |i|pagename|runs| 20:10:04 INFO - PROCESS | 7521 | |0;ai-astar;110;111;105;110;111;111;103;110;111;116 20:10:04 INFO - PROCESS | 7521 | |1;audio-beat-detection;144;123;145;170;133;155;152;123;163;122 20:10:04 INFO - PROCESS | 7521 | |2;audio-dft;160;159;159;161;161;161;161;161;162;159 20:10:04 INFO - PROCESS | 7521 | |3;audio-fft;72;73;101;91;74;72;70;100;89;72 20:10:04 INFO - PROCESS | 7521 | |4;audio-oscillator;93;93;135;92;94;93;135;93;93;131 20:10:04 INFO - PROCESS | 7521 | |5;imaging-gaussian-blur;109;110;111;109;109;109;109;109;109;109 20:10:04 INFO - PROCESS | 7521 | |6;imaging-darkroom;146;145;145;146;146;145;146;147;147;145 20:10:04 INFO - PROCESS | 7521 | |7;imaging-desaturate;96;96;96;95;96;96;96;95;96;96 20:10:04 INFO - PROCESS | 7521 | |8;json-parse-financial;57;57;56;57;57;57;57;67;56;56 20:10:04 INFO - PROCESS | 7521 | |9;json-stringify-tinderbox;69;70;69;68;69;69;69;68;69;70 20:10:04 INFO - PROCESS | 7521 | |10;stanford-crypto-aes;88;84;85;85;85;83;93;86;85;84 20:10:04 INFO - PROCESS | 7521 | |11;stanford-crypto-ccm;114;120;122;120;112;123;120;116;115;122 20:10:04 INFO - PROCESS | 7521 | |12;stanford-crypto-pbkdf2;141;150;149;150;151;139;148;161;147;142 20:10:04 INFO - PROCESS | 7521 | |13;stanford-crypto-sha256-iterative;66;69;65;65;67;66;67;72;64;67 20:10:04 INFO - PROCESS | 7521 | __end_tp_report 20:10:04 INFO - PROCESS | 7521 | __start_cc_report 20:10:04 INFO - PROCESS | 7521 | _x_x_mozilla_cycle_collect,912 20:10:04 INFO - PROCESS | 7521 | __end_cc_report 20:10:04 INFO - PROCESS | 7521 | __startTimestamp1450930204871__endTimestamp 20:10:04 INFO - PROCESS | 7521 | 20:10:04 INFO - PROCESS | 7521 | ------- Summary: start ------- 20:10:04 INFO - PROCESS | 7521 | Number of tests: 14 20:10:04 INFO - PROCESS | 7521 | 20:10:04 INFO - PROCESS | 7521 | [#0] ai-astar Cycles:10 Average:109.80 Median:111.00 stddev:3.55 (3.2%) stddev-sans-first:3.77 20:10:04 INFO - PROCESS | 7521 | Values: 110.0 111.0 105.0 110.0 111.0 111.0 103.0 110.0 111.0 116.0 20:10:04 INFO - PROCESS | 7521 | 20:10:04 INFO - PROCESS | 7521 | [#1] audio-beat-detection Cycles:10 Average:143.00 Median:148.50 stddev:17.32 (11.7%) stddev-sans-first:18.37 20:10:04 INFO - PROCESS | 7521 | Values: 144.0 123.0 145.0 170.0 133.0 155.0 152.0 123.0 163.0 122.0 20:10:04 INFO - PROCESS | 7521 | 20:10:04 INFO - PROCESS | 7521 | [#2] audio-dft Cycles:10 Average:160.40 Median:161.00 stddev:1.07 (0.7%) stddev-sans-first:1.13 20:10:04 INFO - PROCESS | 7521 | Values: 160.0 159.0 159.0 161.0 161.0 161.0 161.0 161.0 162.0 159.0 20:10:04 INFO - PROCESS | 7521 | 20:10:04 INFO - PROCESS | 7521 | [#3] audio-fft Cycles:10 Average:81.40 Median:72.50 stddev:12.47 (17.2%) stddev-sans-first:12.76 20:10:04 INFO - PROCESS | 7521 | Values: 72.0 73.0 101.0 91.0 74.0 72.0 70.0 100.0 89.0 72.0 20:10:04 INFO - PROCESS | 7521 | 20:10:04 INFO - PROCESS | 7521 | [#4] audio-oscillator Cycles:10 Average:105.20 Median:93.00 stddev:19.68 (21.2%) stddev-sans-first:20.37 20:10:04 INFO - PROCESS | 7521 | Values: 93.0 93.0 135.0 92.0 94.0 93.0 135.0 93.0 93.0 131.0 20:10:04 INFO - PROCESS | 7521 | 20:10:04 INFO - PROCESS | 7521 | [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 20:10:04 INFO - PROCESS | 7521 | Values: 109.0 110.0 111.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 20:10:04 INFO - PROCESS | 7521 | 20:10:04 INFO - PROCESS | 7521 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 20:10:04 INFO - PROCESS | 7521 | Values: 146.0 145.0 145.0 146.0 146.0 145.0 146.0 147.0 147.0 145.0 20:10:04 INFO - PROCESS | 7521 | 20:10:04 INFO - PROCESS | 7521 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 20:10:04 INFO - PROCESS | 7521 | Values: 96.0 96.0 96.0 95.0 96.0 96.0 96.0 95.0 96.0 96.0 20:10:04 INFO - PROCESS | 7521 | 20:10:04 INFO - PROCESS | 7521 | [#8] json-parse-financial Cycles:10 Average:57.70 Median:57.00 stddev:3.30 (5.8%) stddev-sans-first:3.49 20:10:04 INFO - PROCESS | 7521 | Values: 57.0 57.0 56.0 57.0 57.0 57.0 57.0 67.0 56.0 56.0 20:10:04 INFO - PROCESS | 7521 | 20:10:04 INFO - PROCESS | 7521 | [#9] json-stringify-tinderbox Cycles:10 Average:69.00 Median:69.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 20:10:04 INFO - PROCESS | 7521 | Values: 69.0 70.0 69.0 68.0 69.0 69.0 69.0 68.0 69.0 70.0 20:10:04 INFO - PROCESS | 7521 | 20:10:04 INFO - PROCESS | 7521 | [#10] stanford-crypto-aes Cycles:10 Average:85.80 Median:85.00 stddev:2.86 (3.4%) stddev-sans-first:2.92 20:10:04 INFO - PROCESS | 7521 | Values: 88.0 84.0 85.0 85.0 85.0 83.0 93.0 86.0 85.0 84.0 20:10:04 INFO - PROCESS | 7521 | 20:10:04 INFO - PROCESS | 7521 | [#11] stanford-crypto-ccm Cycles:10 Average:118.40 Median:120.00 stddev:3.84 (3.2%) stddev-sans-first:3.72 20:10:04 INFO - PROCESS | 7521 | Values: 114.0 120.0 122.0 120.0 112.0 123.0 120.0 116.0 115.0 122.0 20:10:04 INFO - PROCESS | 7521 | 20:10:04 INFO - PROCESS | 7521 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.80 Median:149.50 stddev:6.27 (4.2%) stddev-sans-first:6.15 20:10:04 INFO - PROCESS | 7521 | Values: 141.0 150.0 149.0 150.0 151.0 139.0 148.0 161.0 147.0 142.0 20:10:04 INFO - PROCESS | 7521 | 20:10:04 INFO - PROCESS | 7521 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:2.30 (3.4%) stddev-sans-first:2.42 20:10:04 INFO - PROCESS | 7521 | Values: 66.0 69.0 65.0 65.0 67.0 66.0 67.0 72.0 64.0 67.0 20:10:04 INFO - PROCESS | 7521 | -------- Summary: end -------- 20:10:04 INFO - PROCESS | 7521 | 20:10:05 INFO - TEST-INFO | 7521: exit 0 20:10:05 INFO - TEST-OK | kraken | took 58453ms 20:10:05 INFO - TEST-START | v8_7 20:10:05 INFO - operating with platform_type : linux_ 20:10:05 INFO - Initialising browser for v8_7 test... 20:10:05 INFO - TEST-INFO | started process 7767 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpAnuVj9/profile http://localhost:34699/getInfo.html) 20:10:09 INFO - PROCESS | 7767 | __metrics Screen width/height:1600/1200 20:10:09 INFO - PROCESS | 7767 | colorDepth:24 20:10:09 INFO - PROCESS | 7767 | Browser inner width/height: 1024/697 20:10:09 INFO - PROCESS | 7767 | __metrics 20:10:09 INFO - PROCESS | 7767 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 20:10:09 INFO - PROCESS | 7767 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:10:10 INFO - TEST-INFO | 7767: exit 0 20:10:10 INFO - Browser initialized. 20:10:10 INFO - Running cycle 1/1 for v8_7 test... 20:10:10 INFO - TEST-INFO | started process 7851 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpAnuVj9/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:10:22 INFO - PROCESS | 7851 | RSS: Main: 149110784 20:10:22 INFO - PROCESS | 7851 | 20:10:43 INFO - PROCESS | 7851 | Cycle 1(1): loaded http://localhost:34699/tests/v8_7/run.html (next: http://localhost:34699/tests/v8_7/run.html) 20:10:44 INFO - PROCESS | 7851 | RSS: Main: 621486080 20:10:44 INFO - PROCESS | 7851 | 20:10:44 INFO - PROCESS | 7851 | __start_tp_report 20:10:44 INFO - PROCESS | 7851 | _x_x_mozilla_page_load 20:10:44 INFO - PROCESS | 7851 | _x_x_mozilla_page_load_details 20:10:44 INFO - PROCESS | 7851 | |i|pagename|runs| 20:10:44 INFO - PROCESS | 7851 | |0;Richards;165.39861065167054 20:10:44 INFO - PROCESS | 7851 | |1;DeltaBlue;190.5487804878049 20:10:44 INFO - PROCESS | 7851 | |2;Encrypt;282.80542986425337 20:10:44 INFO - PROCESS | 7851 | |3;Decrypt;5186.5284974093265 20:10:44 INFO - PROCESS | 7851 | |4;RayTrace;1100.1100110011 20:10:44 INFO - PROCESS | 7851 | |5;Earley;789.8894154818325 20:10:44 INFO - PROCESS | 7851 | |6;Boyer;12256.09756097561 20:10:44 INFO - PROCESS | 7851 | |7;RegExp;25897.4358974359 20:10:44 INFO - PROCESS | 7851 | |8;Splay;676.747311827957 20:10:44 INFO - PROCESS | 7851 | |9;NavierStokes;4859.223300970873 20:10:44 INFO - PROCESS | 7851 | __end_tp_report 20:10:44 INFO - PROCESS | 7851 | __startTimestamp1450930244018__endTimestamp 20:10:44 INFO - PROCESS | 7851 | 20:10:44 INFO - PROCESS | 7851 | ------- Summary: start ------- 20:10:44 INFO - PROCESS | 7851 | Number of tests: 10 20:10:44 INFO - PROCESS | 7851 | 20:10:44 INFO - PROCESS | 7851 | [#0] Richards Cycles:1 Average:165.40 Median:165.40 stddev:0.00 (0.0%) 20:10:44 INFO - PROCESS | 7851 | Values: 165.4 20:10:44 INFO - PROCESS | 7851 | 20:10:44 INFO - PROCESS | 7851 | [#1] DeltaBlue Cycles:1 Average:190.55 Median:190.55 stddev:0.00 (0.0%) 20:10:44 INFO - PROCESS | 7851 | Values: 190.5 20:10:44 INFO - PROCESS | 7851 | 20:10:44 INFO - PROCESS | 7851 | [#2] Encrypt Cycles:1 Average:282.81 Median:282.81 stddev:0.00 (0.0%) 20:10:44 INFO - PROCESS | 7851 | Values: 282.8 20:10:44 INFO - PROCESS | 7851 | 20:10:44 INFO - PROCESS | 7851 | [#3] Decrypt Cycles:1 Average:5186.53 Median:5186.53 stddev:0.00 (0.0%) 20:10:44 INFO - PROCESS | 7851 | Values: 5186.5 20:10:44 INFO - PROCESS | 7851 | 20:10:44 INFO - PROCESS | 7851 | [#4] RayTrace Cycles:1 Average:1100.11 Median:1100.11 stddev:0.00 (0.0%) 20:10:44 INFO - PROCESS | 7851 | Values: 1100.1 20:10:44 INFO - PROCESS | 7851 | 20:10:44 INFO - PROCESS | 7851 | [#5] Earley Cycles:1 Average:789.89 Median:789.89 stddev:0.00 (0.0%) 20:10:44 INFO - PROCESS | 7851 | Values: 789.9 20:10:44 INFO - PROCESS | 7851 | 20:10:44 INFO - PROCESS | 7851 | [#6] Boyer Cycles:1 Average:12256.10 Median:12256.10 stddev:0.00 (0.0%) 20:10:44 INFO - PROCESS | 7851 | Values: 12256.1 20:10:44 INFO - PROCESS | 7851 | 20:10:44 INFO - PROCESS | 7851 | [#7] RegExp Cycles:1 Average:25897.44 Median:25897.44 stddev:0.00 (0.0%) 20:10:44 INFO - PROCESS | 7851 | Values: 25897.4 20:10:44 INFO - PROCESS | 7851 | 20:10:44 INFO - PROCESS | 7851 | [#8] Splay Cycles:1 Average:676.75 Median:676.75 stddev:0.00 (0.0%) 20:10:44 INFO - PROCESS | 7851 | Values: 676.7 20:10:44 INFO - PROCESS | 7851 | 20:10:44 INFO - PROCESS | 7851 | [#9] NavierStokes Cycles:1 Average:4859.22 Median:4859.22 stddev:0.00 (0.0%) 20:10:44 INFO - PROCESS | 7851 | Values: 4859.2 20:10:44 INFO - PROCESS | 7851 | -------- Summary: end -------- 20:10:44 INFO - PROCESS | 7851 | 20:10:44 INFO - TEST-INFO | 7851: exit 0 20:10:44 INFO - TEST-OK | v8_7 | took 39141ms 20:10:44 INFO - SUITE-END | took 1211s 20:10:45 INFO - Completed test suite (00:20:11) 20:10:45 INFO - Working with test: dromaeo_css 20:10:45 INFO - Generating results file: dromaeo_css 20:10:45 INFO - Working with test: kraken 20:10:45 INFO - Generating results file: kraken 20:10:45 INFO - javascript benchmark 20:10:45 INFO - Working with test: v8_7 20:10:45 INFO - Generating results file: v8_7 20:10:45 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:10:45 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 20:10:45 INFO - process_Request line: dromaeo_css 7012.34 graph.html#tests=[[72,64,35]] 20:10:45 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:10:45 INFO - process_Request line: kraken 1496.20 graph.html#tests=[[232,64,35]] 20:10:45 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:10:45 INFO - process_Request line: v8_7 20760.17 graph.html#tests=[[230,64,35]] 20:10:45 INFO - RETURN: dromaeo_css: 7012.34 20:10:45 INFO - RETURN: kraken: 1496.20 20:10:45 INFO - RETURN: v8_7: 20760.17 20:10:45 INFO - javascript benchmark 20:10:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3130.2643878688505, 3191.585093937788, 3230.1924518870296, 3233.1917020744813, 3256.413845507809, 5197.298364720761, 5275.419703832576, 5362.27609272748, 5484.698341591211, 5534.557235421162, 5295.973520132394, 5430.294061771974, 5441.183822426638, 5483.396826349099, 5491.0116179087745, 4938.407391113072, 4944.0, 4970.527799859007, 4991.975040124794, 5013.448520662724, 4845.709257444564, 4980.352554167953, 5007.549320561149, 5014.348134742479, 5064.848054558369, 4832.73419961902, 4886.877828054292, 4905.583025442842, 4937.037277730844, 4962.627802914778, 4900.411950565955, 4903.117101937637, 4905.901881962376, 4935.605151587864, 4948.703077815307, 4773.5226477352335, 4861.611071114302, 4886.877828054292, 4899.144071347312, 4923.18767403378, 5230.843074707765, 5293.735313234323, 5302.098643230622, 5303.814366497154, 5304.522592966651, 5940.495057920039, 5945.197398351211, 5950.9107363389585, 5961.493273071794, 5974.581779275452, 5792.247007888989, 5912.14273930282, 5975.372585878464, 5994.910076348859, 6007.4893634041155, 5369.543588794957, 5413.052715774724, 5413.864653383697, 5415.0523658359625, 5462.535684466825, 6023.789167379121, 6127.662978536223, 6131.50947924165, 6131.785387511505, 6138.294096178907, 5593.636413633101, 5634.492895639412, 5685.005124103265, 5890.852728681817, 5921.585489015728, 5714.371419143891, 5772.913406298909, 5773.24947756789, 5790.652560846278, 5835.737391817378, 5783.421657834183, 5835.153902684087, 5842.737076831553, 5844.240248767718, 5847.795327163529, 5656.745446454919, 5709.429057094258, 5754.5971781975695, 5838.299404071454, 5841.1238314253205, 4455.532169122261, 4485.641148708096, 4488.304312831517, 4510.1656193604285, 4525.298578720303, 3964.980175099106, 3975.8012099394914, 3981.7810020448574, 4003.219372222447, 4061.431399604058, 5260.13207820713, 5339.3058902342445, 5355.410904800468, 5373.328333958255, 5374.167004114369, 5746.9712651436475, 5806.390329015477, 5836.533077353802, 5845.1232315153065, 5883.911741323884, 5367.946320536745, 5370.731463426813, 5370.865728356823, 5376.865578360573, 5381.811636592701, 4840.29815676732, 4941.851744447672, 4951.5048495150195, 5049.722265275445, 5083.085044691991, 5939.4357536034, 5981.431763982415, 5985.880282394328, 6051.425114614105, 6057.18228039209, 5867.911981320369, 5870.383609721089, 5871.530277577869, 5874.882502349844, 5876.147958545901, 5807.622504537191, 5946.762129514944, 6025.698715064317, 6044.546659000504, 6047.365026672136, 5758.568107391879, 5762.444140082071, 5763.538916886555, 5813.302403711582, 5871.7651293947765, 5856.267966504187, 5858.033424484912, 5860.648361098348, 5861.882762344814, 5884.529237660891, 5594.0769772987005, 5722.2561067061015, 5724.084146536534, 5734.741936612779, 5745.052066408995, 5693.259876216065, 5760.452756988079, 5764.827055188351, 5771.8557036074435, 5813.215215945793, 5680.346760122638, 5689.601727879009, 5694.202811606296, 5697.373288938296, 5700.800471983626, 5520.503154716095, 5652.773889044557, 5697.515711164598, 5735.4551317624755, 5774.364819869895, 5512.980098681756, 5517.668939863621, 5523.944760552343, 5527.419620939904, 5560.777568897199], "unit": "score", "name": "dojo.html", "value": 5363.056167455018}, {"lowerIsBetter": false, "replicates": [552.6131707804535, 597.5846786483396, 606.3269770554683, 613.9293981192164, 614.1892701633843, 29852.701472985264, 30624.0, 39491.21017579647, 40232.59767402325, 40273.0, 43707.0, 44571.77714111433, 44624.107517849705, 44657.0, 44719.55280447195, 7618.1620021797835, 8787.604557794915, 8957.507337096456, 8971.820563588724, 8975.326850486206, 7746.49647772893, 7848.0, 7849.411294152933, 10443.321184123046, 10719.142468602533, 10441.0, 10538.0, 10546.419946902917, 10547.789044219111, 10549.0, 10429.895701043006, 10546.578136874516, 10553.683389498327, 10565.524551395129, 10568.999999999962, 7817.218278172194, 8027.0, 10247.282690211689, 10440.63457778974, 10447.79104417915, 38343.42484862729, 38400.807995960124, 38500.614993850264, 38651.61348386508, 38664.0, 3371.4100032494216, 3632.4551317302617, 3885.9896426928917, 3944.4280579315837, 4032.354823228269, 30974.519624079538, 31452.842735786402, 31481.37037259242, 31677.841610792027, 32199.195020124684, 3939.310620641405, 3947.1513624570566, 3976.3439032559595, 4022.8994275143064, 4075.6331930126134, 285782.0, 286473.0, 286595.0, 287210.0, 287428.0, 53113.2033019505, 62286.68856655688, 62642.0, 62837.37162628407, 62867.37132628615, 53249.2012619811, 70758.0, 72180.63909680418, 72429.0, 72654.54690906152, 14742.484013059491, 14829.925850370895, 14911.179885106423, 14935.477258296125, 14937.551873443814, 11140.0, 11202.103831693445, 11217.149170386958, 11225.270357426905, 11231.326120432801, 20208.797912020986, 20302.0, 20340.593188136154, 20372.89813550923, 20546.28088016912, 7634.6946122155605, 7857.607119643995, 7861.882071768928, 7867.173946735625, 7972.681092756225, 935.8830146231721, 1001.4441984698562, 1003.844404117363, 1015.263933648114, 1045.6235755128148, 28774.712252877624, 29036.41927161445, 29080.418391632047, 29128.417431651247, 29343.413131737674, 1029.264076185516, 1034.813733527972, 1048.171944164102, 1073.431081526792, 1079.5681727309138, 13570.321483925763, 13681.11072780286, 13696.315184240748, 13773.173609583257, 13877.0, 247351.0, 250538.0, 251118.0, 251310.0, 251595.0, 47686.0, 47722.76138619285, 47785.5221447788, 47932.28101578479, 48025.0, 1332.6401871494836, 1351.4999450203488, 1354.4920654754467, 1355.3494322725146, 1359.5989183190982, 23512.0, 33800.66199338074, 34922.0, 35291.29417411586, 35316.0, 48398.75800620974, 49199.75400122976, 49236.50763492462, 49257.75371123121, 49343.506564933894, 227429.0, 229676.0, 229792.0, 230507.84746076833, 231148.0, 34815.65184348124, 38459.6154038456, 42258.78870605627, 43274.78362608167, 49169.754151230445, 46813.76593117149, 46854.29718554293, 47913.0, 48098.27852582284, 48133.27800082931, 39402.40896386614, 39523.80238098791, 40752.59247407488, 41587.7920610395, 42178.836587255464, 39924.35635898044, 40723.796381017906, 41137.58862411338, 43636.78181609072, 43906.780466097465, 39347.0, 39807.80096099501, 39850.20299593934, 40062.599374007055, 40404.79797600993, 35495.64504355027, 35852.64147358597, 36218.81890590636, 36230.63769362378, 36641.81679091587, 26713.465730685668, 27464.15101849987, 27538.449231014867, 27653.861730692024, 27709.861450692617], "unit": "score", "name": "ext.html", "value": 19167.626962832368}, {"lowerIsBetter": false, "replicates": [352.7846568571271, 356.9411047177216, 357.7370632585051, 358.85825099085855, 361.5408431292259, 14181.78727319091, 14514.709705805877, 15777.526674199778, 16014.0, 16694.415695450647, 16137.354505819752, 16529.173541322947, 17094.145292735375, 17377.391791287308, 17428.82571174288, 5416.133418653026, 5555.8888822223735, 5556.361018482886, 5564.10974244121, 5564.527015203692, 4026.557078721353, 4128.050548373876, 5460.044492213847, 5928.6739229342365, 6031.0, 5975.701214939258, 5988.580799344048, 5994.220751302325, 6012.278526576817, 6024.096385542181, 5965.46310832025, 6122.510199184055, 6122.846928826771, 6127.632342059491, 6129.356417576158, 5301.310829592167, 5371.0, 5381.192821076831, 5404.0, 5404.162354835007, 20892.582148357098, 20893.791062089487, 21044.5791084179, 21286.680699789515, 21338.146474141016, 2233.7431195412573, 2245.2478419729246, 2341.7775311345395, 2364.680768096302, 2392.808575313971, 13023.869761302456, 13030.80453793194, 13059.934700326532, 13125.737485250336, 13555.932220338935, 1785.874988750775, 1808.9909550452296, 1858.8884666920028, 1868.1914771850788, 1873.72830939513, 58696.41303586952, 61170.0, 61987.0, 62202.0, 62351.376486235466, 9640.276979226586, 9851.113399794052, 10007.349522281029, 10022.3485473444, 10084.092431681183, 13018.544350947672, 13060.21638701681, 13067.215967042008, 13074.869251307555, 13091.214527128403, 7237.421006319481, 7257.310555497219, 7299.160596531467, 7303.59830209333, 7398.519096258834, 6849.075374824434, 6856.211535673362, 6890.2420733719255, 6908.792736217922, 6909.032735417046, 5888.735006924699, 5903.527717782567, 5950.137230101697, 5978.744463662592, 6037.486813620803, 1680.7142785726212, 1732.0727969731115, 1755.5523341547823, 1788.2578729827237, 1792.8834625749284, 903.0969030969031, 931.5481991234246, 958.6213445688913, 986.8667729856521, 1098.7033500954697, 16973.49079527616, 17282.65434691299, 17464.738028929576, 17476.650466990588, 17594.73607895857, 980.2745967983783, 985.7387792235063, 992.9007099290013, 1007.7682133109425, 1050.6952983634812, 9638.95180524093, 10070.44612546317, 10171.694849154537, 10188.643397481053, 10203.489825508843, 539466.0, 546359.0, 548048.0, 559755.0, 563126.0, 80082.19917800747, 80995.0, 81294.59352703199, 81619.18380816234, 82291.17708822835, 1154.751728378386, 1161.4715304536585, 1165.1669056624723, 1173.4895320535595, 1181.5037684172669, 15518.767218491506, 15605.921970390076, 15780.92109539445, 15823.841761582697, 15901.840981590498, 34668.306633866676, 35379.115522111126, 35944.64055359413, 35987.46018809772, 36185.27629447449, 46211.537884620724, 46557.30164047474, 46747.29879051749, 47598.52401475941, 50889.745551272004, 9315.25477961775, 9321.741564888924, 9397.449420845483, 9415.482148481899, 9438.103380178873, 11523.711907202387, 11718.121140914294, 11748.060155187393, 11755.588554400554, 13734.519291824738, 11813.468393922121, 13012.28432436225, 14122.646933826325, 14332.785008224677, 14354.3540540678, 13538.390772415069, 13997.020208585709, 14117.505887293895, 14284.785728213878, 14309.785353219502, 14524.273786310854, 14592.854071459575, 14691.485797997018, 15323.157226352212, 15343.0, 9128.0, 9142.131497507726, 9405.43567385959, 9427.245820334494, 9440.527973601429, 10062.39625622465, 12641.93679031599, 14690.485832995793, 15002.924985375003, 15213.467528636445], "unit": "score", "name": "jquery.html", "value": 9022.950567720725}, {"lowerIsBetter": false, "replicates": [1516.0221657031223, 1669.9165041747913, 1726.5079452356076, 1731.904745239012, 1756.587202007528, 6599.439047680947, 7185.784426467208, 7368.373688236493, 7382.040334756474, 7390.630468476568, 7286.453515986309, 7439.628018599075, 7449.180590135081, 7455.850882982337, 7466.440016998733, 1929.0644037641803, 1964.6836619464993, 1972.5463143476936, 2210.35899589119, 2254.7068881045443, 1933.4393026022437, 2220.9222677206303, 2265.105283413051, 2267.5691618592414, 2269.375921621559, 2156.568686262746, 2164.166795783619, 2192.199847055829, 2196.8352373571965, 2228.1310288987306, 2207.845450818443, 2222.822174226058, 2235.3629215673536, 2236.8546044507057, 2239.1379318962154, 2197.8681279123302, 2246.056656204398, 2246.067881829039, 2246.326102169359, 2246.5506898620342, 7125.893111603278, 7153.0, 7177.9282207177785, 7184.0, 7184.640767961633, 4431.822727090913, 4501.887452813706, 4507.211238033331, 4508.842190523349, 4545.749983750892, 3084.506478963355, 3090.088423914928, 3122.703343182394, 3128.358686469291, 3136.702013308732, 1061.2836335473523, 1086.5708045322133, 1103.8840921703186, 1137.8634563852308, 1145.6333973128603, 9833.606655733834, 9880.160186384166, 9889.109980101754, 9982.351147175483, 9986.700398987969, 4027.8791636250958, 4056.492938382702, 4095.713300069026, 4098.364753463218, 4109.465769449952, 8786.956065219762, 8808.91191088081, 8811.383203175845, 8820.691275805317, 8822.470651760786, 4522.615577675869, 4530.22986092365, 4532.9773351133035, 4566.95433045672, 4571.245744452194, 4113.239050775616, 4129.669626429878, 4151.647109995623, 4157.10622216225, 4166.937495937564, 3295.5880514935634, 3434.862605495802, 3446.3451944130534, 3459.3081383723356, 3481.912952176165, 1061.9575216991234, 1075.4353964168874, 1146.60442147459, 1156.7166044319197, 1165.6561314412268, 976.077606661712, 976.2531663277598, 980.1864452504404, 1048.182417714184, 1197.203859433467, 6557.868842623217, 6629.138212032405, 6636.767713130113, 6645.269020407752, 6649.501287403367, 582.2779753106117, 586.0067186119571, 590.9704514774244, 593.0659211741524, 741.1476801678006, 5028.472010438924, 5121.718305493234, 5122.846314610568, 5123.103456895028, 5127.051495473349, 8620.78448038804, 8746.0, 8872.689455869013, 8902.332325075646, 8980.191782739585, 8757.430767000125, 8832.779180520538, 8837.0, 8862.246709029805, 8887.511186884783, 6719.160104986779, 7012.333828286304, 7060.470464715167, 7086.149662040485, 7089.184743754534, 6635.701393437211, 6702.095217145623, 6705.430038446787, 6706.631135287606, 6711.228208755861, 7905.723299684483, 8116.878246826421, 8138.470999385021, 8145.348372130334, 8148.1037085919315, 8153.959230203811, 8198.344132469269, 8317.95841020791, 8334.541600212047, 8355.623996920032, 6389.55273130895, 6411.0, 6458.54790164684, 6467.094606755152, 6485.0, 6417.069524918954, 6460.967695161494, 6930.3762661360715, 7027.332403421667, 7029.3673569379, 6576.342365763386, 6607.273199948098, 6673.933260667525, 6742.190937087581, 6877.1747390313485, 6386.904196436964, 6592.143021407186, 6665.600063995982, 6706.731730730716, 6757.662116894037, 6586.242582103119, 6605.174353205849, 6617.867642647217, 6648.301928297459, 6649.035889795856, 5887.882242355215, 5909.793157239476, 5921.555883308855, 5922.052471604523, 5924.911126333022, 5973.313068997121, 6043.969780151071, 6049.092636104443, 6053.60651557665, 6114.7554097837365], "unit": "score", "name": "mootools.html", "value": 4213.649136579136}, {"lowerIsBetter": false, "replicates": [318.17116411747395, 323.6375259709125, 328.2368493253187, 331.6948407465132, 331.87720543398933, 5923.348431672518, 5927.644341339517, 5967.045272756354, 5986.2517185351835, 6024.1566180734735, 5873.970630146854, 5879.52963762899, 5890.970545147268, 5892.0, 5894.056950887859, 4554.157480866033, 4558.361829343895, 4561.087782443508, 4566.018306064196, 4566.931496027562, 4387.7367357958465, 4537.047220083787, 4542.772861356935, 4562.292844609091, 4566.0, 4475.440569928759, 4493.573110554508, 4494.640428765691, 4499.955000449986, 4503.662225333097, 4272.401863739079, 4443.333499975013, 4457.531959144292, 4484.730916145042, 4501.504834468205, 3784.6026167252317, 3826.3112639724836, 3898.8440462381473, 3905.1408690088133, 3910.1006768443135, 5604.719764011783, 5614.6631202128, 5634.5210657093785, 5647.040003199466, 5654.067078931971, 4971.055499455092, 5056.924146137811, 5101.489851014906, 5194.0910340690225, 5216.061109000379, 6190.721417536221, 6248.187735594389, 6253.562250642457, 6258.84211420884, 6262.342454042351, 4309.741415515079, 4313.202057619351, 4319.02821865081, 4319.69762116652, 4322.589354011364, 6360.300366959677, 6433.292337842833, 6486.610803351814, 6505.804825855232, 6522.836929076763, 4376.256036473807, 4387.605115539617, 4415.955840441618, 4444.933326000112, 4448.755318457451, 4500.437445319335, 4501.257292546758, 4502.167099086614, 4506.639468842484, 4508.413906192174, 5220.190870415092, 5224.824414506706, 5229.450907654642, 5233.895322093613, 5233.921491177635, 6120.479759220516, 6302.65335406557, 6328.873422531524, 6335.303116657164, 6343.365663433619, 1554.2461905975592, 1585.722498562747, 1587.9995602770412, 1589.1418633937776, 1590.514892957659, 1053.5733028123623, 1057.3655806516028, 1058.3808472043786, 1066.168388656849, 1072.8605281313535, 5980.312264089685, 5984.012637914695, 5993.0710739835395, 5994.940050599438, 5998.340182579913, 6449.161608990801, 6502.317256687979, 6518.869622607522, 6519.934800652028, 6524.771632992823, 5985.670788106609, 5986.431289027535, 5990.460858522754, 5993.820185394445, 5993.970030149909, 3451.137215696076, 3504.404251277289, 3523.3129539739502, 3533.611302756695, 3537.5931767846514, 6719.865602687919, 6754.3921047106, 6756.087928129639, 6768.72925083001, 6778.898316525256, 6448.580842245239, 6758.763443279461, 6762.459003279726, 6762.932370676329, 6767.830804229835, 6244.0321750128805, 6557.868842623121, 6716.496262780213, 6755.155605549405, 6761.8647627047185, 6530.738770449128, 6532.346765323429, 6539.607623542603, 6546.770863019771, 6551.50863685216, 6491.188601424822, 6491.253505846888, 6495.512836537184, 6498.252700939453, 6507.219133703986, 6597.0764093026055, 6710.83222919431, 6717.093192418961, 6728.259891411843, 6730.125083739083, 4385.320275357325, 4436.5119836817275, 4442.200403927324, 4443.511213766547, 4443.688941774045, 6545.476361890942, 6566.606003639797, 6572.80281591553, 6575.53971222029, 6576.079348891255, 6257.2804127525915, 6397.584157029778, 6400.9039864403, 6403.07155462446, 6403.423691867754, 6331.936680633319, 6376.4580010697755, 6377.7767778127545, 6387.457066149429, 6394.776182833579, 6273.059041143682, 6274.090256912813, 6274.309825919237, 6274.780382686584, 6279.811605651837, 6262.2172228471445, 6424.164858568356, 6455.2576453708425, 6458.935410645833, 6459.739091318189, 6288.5598008138995, 6291.402316779899, 6298.370162983665, 6302.9684851577285, 6303.905441418291], "unit": "score", "name": "prototype.html", "value": 4737.860736607624}, {"lowerIsBetter": false, "replicates": [749.3817600479603, 768.1627026541073, 825.5872063968015, 872.8647059705739, 876.1763941894619, 14214.502492412756, 14370.209638469893, 14387.496437624684, 14472.493462728806, 14502.41990320386, 12290.877091229086, 12380.628581142557, 12389.442475088621, 12405.875941240585, 12408.06939479538, 689.035350509286, 692.6259819697358, 819.1644522586957, 835.5028757889046, 837.798928257217, 829.784256093414, 831.8336332733447, 832.1553623072587, 836.5775283481834, 839.0518713853337, 894.1639567004871, 896.2964073202537, 898.1018981018981, 898.27239935652, 898.5776684958059, 731.7292601737338, 733.8899165125221, 873.5021038008338, 882.0473888200792, 884.3986089459165, 648.5330561995356, 651.6741629185407, 652.341135453191, 652.5464801962638, 652.8106849013781, 13826.377812998438, 13978.370973306226, 13988.230647314394, 13996.93001534996, 13997.3701183447, 12085.758284834343, 12514.1865778725, 12614.495420183273, 12799.19249257952, 12824.743505129845, 10250.282480226388, 10348.430836304, 10427.79144417115, 10552.472376381227, 10959.945200274027, 3614.7469677122613, 3663.0292972362345, 3671.522702048743, 3736.663700266989, 3739.7943113128767, 46553.30170047452, 46645.533544664795, 46783.76608116938, 46867.062658746974, 47092.99999999966, 9975.850362244571, 10257.435841028815, 10305.690829275134, 10638.946805265925, 10939.945300273606, 18957.52606184829, 19023.809761902205, 19041.0, 19056.428307150807, 19057.428277151706, 7544.735934242275, 7633.809154771176, 7662.5785581792425, 7766.805829854299, 8123.47197432165, 4222.4299719538085, 4237.0, 4239.427677263591, 4252.787360631956, 4329.437173167531, 2984.805987610842, 3017.834019128925, 3018.6679465258803, 3020.4865172920654, 3020.7130322619314, 505.5172310443591, 518.072649956581, 522.0524747583124, 557.5010365722736, 557.8884223155385, 587.9147523609053, 678.633537889544, 680.9591424514545, 698.3191388396375, 716.3767522255566, 8134.59327033646, 8829.823403532022, 9157.771055723528, 9165.0, 9574.617015319309, 530.3079481276893, 638.9872202555923, 660.6828722213364, 664.9268580456146, 716.9498135130491, 3925.4111883217747, 3998.9400158997637, 4187.539370669224, 4398.626116780109, 4415.911681766347, 55391.44608553863, 58521.414785852445, 59060.70469647624, 59125.52186195293, 59163.70418147882, 52503.0, 54021.72989135029, 54220.45779542154, 54277.72861135748, 54304.99999999921, 46486.0, 46960.7651961738, 47787.522124779, 49120.2631960528, 49212.26181607279, 8433.95783021081, 8478.3641226907, 8609.91390086091, 8809.42738721981, 9077.45535267886, 34702.30595388129, 36139.81930090438, 36508.452373214954, 37076.25847482981, 37107.0, 44755.55244447644, 44974.0, 45207.54792452033, 46034.30948535708, 47599.52400475951, 11122.777544449227, 11144.49849756779, 11401.315921044765, 11430.314181149157, 11848.407579621156, 12191.756164876475, 12682.936585317015, 12684.048696347996, 13022.934885325512, 13025.218486890817, 11012.39431831225, 11422.25755325901, 11768.94115529417, 12086.697832554257, 12274.140810143204, 11991.460384282555, 12201.755964880831, 12358.567450139202, 12408.379581021094, 12437.751244974868, 8400.285975692135, 10039.4478303694, 10622.150227981589, 12082.214656047328, 12161.513539458323, 9727.0, 9914.454704991007, 9963.651272205438, 10522.789544209227, 10655.20085993569, 9391.483468409304, 9423.963364030089, 9839.754006149617, 10143.89856101459, 10186.898131018595], "unit": "score", "name": "yui.html", "value": 6420.421798823187}], "name": "dromaeo_css", "value": 7012.335259522562}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 111.0, 105.0, 110.0, 111.0, 111.0, 103.0, 110.0, 111.0, 116.0], "unit": "score", "name": "ai-astar", "value": 109.8}, {"lowerIsBetter": true, "replicates": [144.0, 123.0, 145.0, 170.0, 133.0, 155.0, 152.0, 123.0, 163.0, 122.0], "unit": "score", "name": "audio-beat-detection", "value": 143.0}, {"lowerIsBetter": true, "replicates": [160.0, 159.0, 159.0, 161.0, 161.0, 161.0, 161.0, 161.0, 162.0, 159.0], "unit": "score", "name": "audio-dft", "value": 160.4}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 101.0, 91.0, 74.0, 72.0, 70.0, 100.0, 89.0, 72.0], "unit": "score", "name": "audio-fft", "value": 81.4}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 135.0, 92.0, 94.0, 93.0, 135.0, 93.0, 93.0, 131.0], "unit": "score", "name": "audio-oscillator", "value": 105.2}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 111.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 145.0, 146.0, 146.0, 145.0, 146.0, 147.0, 147.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.8}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [57.0, 57.0, 56.0, 57.0, 57.0, 57.0, 57.0, 67.0, 56.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 57.7}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 69.0, 68.0, 69.0, 69.0, 69.0, 68.0, 69.0, 70.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.0}, {"lowerIsBetter": true, "replicates": [88.0, 84.0, 85.0, 85.0, 85.0, 83.0, 93.0, 86.0, 85.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.8}, {"lowerIsBetter": true, "replicates": [114.0, 120.0, 122.0, 120.0, 112.0, 123.0, 120.0, 116.0, 115.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.4}, {"lowerIsBetter": true, "replicates": [141.0, 150.0, 149.0, 150.0, 151.0, 139.0, 148.0, 161.0, 147.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.8}, {"lowerIsBetter": true, "replicates": [66.0, 69.0, 65.0, 65.0, 67.0, 66.0, 67.0, 72.0, 64.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.8}], "name": "kraken", "value": 1496.2}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.39861065167054], "unit": "score", "name": "Richards", "value": 213.43589200000002}, {"lowerIsBetter": false, "replicates": [190.5487804878049], "unit": "score", "name": "DeltaBlue", "value": 346.9872640000001}, {"lowerIsBetter": false, "replicates": [282.80542986425337], "unit": "score", "name": "Encrypt", "value": 941.2160160000003}, {"lowerIsBetter": false, "replicates": [5186.5284974093265], "unit": "score", "name": "Decrypt", "value": 51.32161138861136}, {"lowerIsBetter": false, "replicates": [1100.1100110011], "unit": "score", "name": "RayTrace", "value": 672.6500009999999}, {"lowerIsBetter": false, "replicates": [789.8894154818325], "unit": "score", "name": "Earley", "value": 843.7421580000001}, {"lowerIsBetter": false, "replicates": [12256.09756097561], "unit": "score", "name": "Boyer", "value": 54.378075621890574}, {"lowerIsBetter": false, "replicates": [25897.4358974359], "unit": "score", "name": "RegExp", "value": 35.17664851485149}, {"lowerIsBetter": false, "replicates": [676.747311827957], "unit": "score", "name": "Splay", "value": 120.41569811320758}, {"lowerIsBetter": false, "replicates": [4859.223300970873], "unit": "score", "name": "NavierStokes", "value": 305.39860139860156}], "name": "v8_7", "value": 20760.171350463916}]} 20:10:45 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "20760.17"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1496.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "7012.34"}}} 20:10:45 INFO - Return code: 0 20:10:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 20:10:45 INFO - # TBPL SUCCESS # 20:10:45 INFO - Running post-action listener: _resource_record_post_action 20:10:45 INFO - Running post-run listener: _resource_record_post_run 20:10:46 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 438272; Write bytes: 316481536; Read time: 252; Write time: 165644 20:10:46 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 8511488; Read time: 0; Write time: 620 20:10:46 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 438272; Write bytes: 307970048; Read time: 252; Write time: 165024 20:10:46 INFO - Running post-run listener: _upload_blobber_files 20:10:46 INFO - Blob upload gear active. 20:10:46 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 20:10:46 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 20:10:46 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', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 20:10:46 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 Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 20:10:47 INFO - (blobuploader) - INFO - Open directory for files ... 20:10:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 20:10:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:10:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:10:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:10:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:10:47 INFO - (blobuploader) - INFO - Done attempting. 20:10:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:10:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:10:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:10:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:10:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:10:48 INFO - (blobuploader) - INFO - Done attempting. 20:10:48 INFO - (blobuploader) - INFO - Iteration through files over. 20:10:48 INFO - Return code: 0 20:10:48 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 20:10:48 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 20:10:48 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f2bf456ecd745f2aba55faefa16f766fdbe588098b86d594187fd12d59ea171ed0a9cab68fb8f18a563490e9dfd9430bdf5a09143bfff8b70da561a473a81da4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/466aba63f3deb202b1c0f72828867bdff8a3ea7c06411f83648074cb7a08eae9cc7f37d7b9bdaf1f1e1ca91ef6d0d3b6ed051d8691cef60ee444c31204847b65"} 20:10:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 20:10:48 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 20:10:48 INFO - Contents: 20:10:48 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f2bf456ecd745f2aba55faefa16f766fdbe588098b86d594187fd12d59ea171ed0a9cab68fb8f18a563490e9dfd9430bdf5a09143bfff8b70da561a473a81da4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/466aba63f3deb202b1c0f72828867bdff8a3ea7c06411f83648074cb7a08eae9cc7f37d7b9bdaf1f1e1ca91ef6d0d3b6ed051d8691cef60ee444c31204847b65"} 20:10:48 INFO - Copying logs to upload dir... 20:10:48 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1283.026817 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2015-12-23 20:10:48.648509) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-23 20:10:48.652679) ========= 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=d3f2be9b0713ec03b22325b2000001be-1450928065.951739-1081682117 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f2bf456ecd745f2aba55faefa16f766fdbe588098b86d594187fd12d59ea171ed0a9cab68fb8f18a563490e9dfd9430bdf5a09143bfff8b70da561a473a81da4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/466aba63f3deb202b1c0f72828867bdff8a3ea7c06411f83648074cb7a08eae9cc7f37d7b9bdaf1f1e1ca91ef6d0d3b6ed051d8691cef60ee444c31204847b65"} build_url:https://queue.taskcluster.net/v1/task/e77BAwq3TPKhnS84yG9ONQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011300 build_url: 'https://queue.taskcluster.net/v1/task/e77BAwq3TPKhnS84yG9ONQ/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/Fx-Team/sha512/f2bf456ecd745f2aba55faefa16f766fdbe588098b86d594187fd12d59ea171ed0a9cab68fb8f18a563490e9dfd9430bdf5a09143bfff8b70da561a473a81da4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/466aba63f3deb202b1c0f72828867bdff8a3ea7c06411f83648074cb7a08eae9cc7f37d7b9bdaf1f1e1ca91ef6d0d3b6ed051d8691cef60ee444c31204847b65"}' ========= master_lag: 0.05 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-23 20:10:48.712496) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 20:10:48.712846) ========= 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=d3f2be9b0713ec03b22325b2000001be-1450928065.951739-1081682117 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004532 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 20:10:48.794983) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-23 20:10:48.795323) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-23 20:10:48.795667) ========= ========= Total master_lag: 0.22 =========