builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-021 starttime: 1451328629.46 results: success (0) buildid: 20151228083140 builduid: 88635c1fcf1c42658e7c08ce1563fd70 revision: 5b9292b9f878471b54498c1a70cecb76d5a409b3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-28 10:50:29.462508) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-28 10:50:29.463178) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-28 10:50:29.463499) ========= 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=ccb4611811c763f2fad71465000001de-1451326949.843446-1081295317 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006441 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-28 10:50:29.496064) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-28 10:50:29.496390) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-28 10:50:29.518847) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 10:50:29.519108) ========= 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=ccb4611811c763f2fad71465000001de-1451326949.843446-1081295317 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004623 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 10:50:29.569311) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-28 10:50:29.569646) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-28 10:50:29.570002) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 10:50:29.570363) ========= 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=ccb4611811c763f2fad71465000001de-1451326949.843446-1081295317 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-28 10:50:29-- 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% 223M=0s 2015-12-28 10:50:30 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.170400 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 10:50:29.754560) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 10:50:29.754870) ========= 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=ccb4611811c763f2fad71465000001de-1451326949.843446-1081295317 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018240 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 10:50:29.804373) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 10:50:29.804728) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5b9292b9f878471b54498c1a70cecb76d5a409b3 --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 5b9292b9f878471b54498c1a70cecb76d5a409b3 --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=ccb4611811c763f2fad71465000001de-1451326949.843446-1081295317 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-28 10:50:30,273 truncating revision to first 12 chars 2015-12-28 10:50:30,273 Setting DEBUG logging. 2015-12-28 10:50:30,273 attempt 1/10 2015-12-28 10:50:30,273 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5b9292b9f878?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-28 10:50:30,523 unpacking tar archive at: fx-team-5b9292b9f878/testing/mozharness/ program finished with exit code 0 elapsedTime=0.525424 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 10:50:30.345040) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-28 10:50:30.345597) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-28 10:50:30.377379) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-28 10:50:30.377920) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-28 10:50:30.378706) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2015-12-28 10:50:30.379228) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --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', '--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=ccb4611811c763f2fad71465000001de-1451326949.843446-1081295317 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:50:30 INFO - MultiFileLogger online at 20151228 10:50:30 in /builds/slave/test-pgo 10:50:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 10:50:30 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 10:50:30 INFO - {'append_to_log': False, 10:50:30 INFO - 'base_work_dir': '/builds/slave/test-pgo', 10:50:30 INFO - 'blob_upload_branch': 'Fx-Team', 10:50:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 10:50:30 INFO - 'branch': 'Fx-Team', 10:50:30 INFO - 'buildbot_json_path': 'buildprops.json', 10:50:30 INFO - 'config_files': ('talos/linux_config.py',), 10:50:30 INFO - 'default_actions': ('clobber', 10:50:30 INFO - 'read-buildbot-config', 10:50:30 INFO - 'download-and-extract', 10:50:30 INFO - 'populate-webroot', 10:50:30 INFO - 'create-virtualenv', 10:50:30 INFO - 'install', 10:50:30 INFO - 'run-tests'), 10:50:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:50:30 INFO - 'download_minidump_stackwalk': True, 10:50:30 INFO - 'download_symbols': 'ondemand', 10:50:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:50:30 INFO - 'tooltool.py': '/tools/tooltool.py', 10:50:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:50:30 INFO - '/tools/misc-python/virtualenv.py')}, 10:50:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:50:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:50:30 INFO - 'installer_path': 'installer.exe', 10:50:30 INFO - 'log_level': 'info', 10:50:30 INFO - 'log_name': 'talos', 10:50:30 INFO - 'log_to_console': True, 10:50:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:50:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:50:30 INFO - 'opt_config_files': (), 10:50:30 INFO - 'pip_index': False, 10:50:30 INFO - 'sps_profile': False, 10:50:30 INFO - 'sps_profile_interval': 0, 10:50:30 INFO - 'suite': 'dromaeojs', 10:50:30 INFO - 'system_bits': '32', 10:50:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:50:30 INFO - 'title': 'talos-linux64-ix-021', 10:50:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:50:30 INFO - 'use_talos_json': True, 10:50:30 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 10:50:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:50:30 INFO - 'work_dir': 'build'} 10:50:30 INFO - ##### 10:50:30 INFO - ##### Running clobber step. 10:50:30 INFO - ##### 10:50:30 INFO - Running pre-action listener: _resource_record_pre_action 10:50:30 INFO - Running main action method: clobber 10:50:30 INFO - rmtree: /builds/slave/test-pgo/build 10:50:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 10:50:31 INFO - Running post-action listener: _resource_record_post_action 10:50:31 INFO - ##### 10:50:31 INFO - ##### Running read-buildbot-config step. 10:50:31 INFO - ##### 10:50:31 INFO - Running pre-action listener: _resource_record_pre_action 10:50:31 INFO - Running main action method: read_buildbot_config 10:50:31 INFO - Using buildbot properties: 10:50:31 INFO - { 10:50:31 INFO - "project": "", 10:50:31 INFO - "product": "firefox", 10:50:31 INFO - "script_repo_revision": "production", 10:50:31 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 10:50:31 INFO - "repository": "", 10:50:31 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 10:50:31 INFO - "buildid": "20151228083140", 10:50:31 INFO - "pgo_build": "True", 10:50:31 INFO - "basedir": "/builds/slave/test-pgo", 10:50:31 INFO - "buildnumber": 389, 10:50:31 INFO - "slavename": "talos-linux64-ix-021", 10:50:31 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:50:31 INFO - "platform": "ubuntu64_hw", 10:50:31 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 10:50:31 INFO - "branch": "fx-team", 10:50:31 INFO - "repo_path": "integration/fx-team", 10:50:31 INFO - "revision": "5b9292b9f878471b54498c1a70cecb76d5a409b3", 10:50:31 INFO - "stage_platform": "linux64-pgo", 10:50:31 INFO - "builduid": "88635c1fcf1c42658e7c08ce1563fd70", 10:50:31 INFO - "slavebuilddir": "test" 10:50:31 INFO - } 10:50:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/7spQg9DMR0WB6z602ZU4Zg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 10:50:31 INFO - Running post-action listener: _resource_record_post_action 10:50:31 INFO - ##### 10:50:31 INFO - ##### Running download-and-extract step. 10:50:31 INFO - ##### 10:50:31 INFO - Running pre-action listener: _resource_record_pre_action 10:50:31 INFO - Running main action method: download_and_extract 10:50:31 INFO - mkdir: /builds/slave/test-pgo/build/tests 10:50: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')]} 10:50:31 INFO - https://queue.taskcluster.net/v1/task/7spQg9DMR0WB6z602ZU4Zg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 10:50:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7spQg9DMR0WB6z602ZU4Zg/artifacts/public/build/test_packages.json 10:50:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7spQg9DMR0WB6z602ZU4Zg/artifacts/public/build/test_packages.json 10:50:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7spQg9DMR0WB6z602ZU4Zg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 10:50:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7spQg9DMR0WB6z602ZU4Zg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 10:50:38 INFO - Downloaded 1302 bytes. 10:50:38 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 10:50:38 INFO - Using the following test package requirements: 10:50:38 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:50:38 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:50:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:50:38 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:50:38 INFO - u'jsshell-linux-x86_64.zip'], 10:50:38 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:50:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:50:38 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:50:38 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:50:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:50:38 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:50:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:50:38 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:50:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:50:38 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:50:38 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:50:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:50:38 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:50:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:50:38 INFO - https://queue.taskcluster.net/v1/task/7spQg9DMR0WB6z602ZU4Zg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:50:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7spQg9DMR0WB6z602ZU4Zg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:50:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7spQg9DMR0WB6z602ZU4Zg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:50:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7spQg9DMR0WB6z602ZU4Zg/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 10:50:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7spQg9DMR0WB6z602ZU4Zg/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 10:50:43 INFO - Downloaded 23191673 bytes. 10:50:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 10:50:43 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:50:43 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 10:50:44 INFO - Return code: 0 10:50:44 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:50:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:50:44 INFO - https://queue.taskcluster.net/v1/task/7spQg9DMR0WB6z602ZU4Zg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:50:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7spQg9DMR0WB6z602ZU4Zg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:50:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7spQg9DMR0WB6z602ZU4Zg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:50:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7spQg9DMR0WB6z602ZU4Zg/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 10:50:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7spQg9DMR0WB6z602ZU4Zg/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 10:50:47 INFO - Downloaded 23191673 bytes. 10:50:47 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 10:50:47 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:50:47 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 10:50:49 INFO - Return code: 0 10:50:49 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')]} 10:50:49 INFO - https://queue.taskcluster.net/v1/task/7spQg9DMR0WB6z602ZU4Zg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:50:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7spQg9DMR0WB6z602ZU4Zg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:50:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7spQg9DMR0WB6z602ZU4Zg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:50:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7spQg9DMR0WB6z602ZU4Zg/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 10:50:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7spQg9DMR0WB6z602ZU4Zg/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 10:50:50 INFO - Downloaded 11132270 bytes. 10:50:50 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 10:50:50 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:50:50 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 10:50:51 INFO - Return code: 0 10:50: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')]} 10:50:51 INFO - https://queue.taskcluster.net/v1/task/7spQg9DMR0WB6z602ZU4Zg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:50:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7spQg9DMR0WB6z602ZU4Zg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:50:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7spQg9DMR0WB6z602ZU4Zg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:50:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7spQg9DMR0WB6z602ZU4Zg/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 10:50:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7spQg9DMR0WB6z602ZU4Zg/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 10:50:52 INFO - Downloaded 54885874 bytes. 10:50:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/7spQg9DMR0WB6z602ZU4Zg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:50:52 INFO - mkdir: /builds/slave/test-pgo/properties 10:50:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 10:50:52 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 10:50:52 INFO - Contents: 10:50:52 INFO - build_url:https://queue.taskcluster.net/v1/task/7spQg9DMR0WB6z602ZU4Zg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:50:52 INFO - Running post-action listener: _resource_record_post_action 10:50:52 INFO - Running post-action listener: set_extra_try_arguments 10:50:52 INFO - ##### 10:50:52 INFO - ##### Running populate-webroot step. 10:50:52 INFO - ##### 10:50:52 INFO - Running pre-action listener: _resource_record_pre_action 10:50:52 INFO - Running main action method: populate_webroot 10:50:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:50:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:50:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:50:52 INFO - '--tppagecycles', 10:50:52 INFO - '7'], 10:50:52 INFO - 'tests': ['tsvgm']}}, 10:50:52 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:50:52 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:50:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:50:52 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:50:52 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:50:52 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:50:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:50:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:50:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:50:52 INFO - 'talos_options': ['--e10s'], 10:50:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:50:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:50:52 INFO - 'tests': ['damp', 'tps']}, 10:50:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:50:52 INFO - 'talos_options': ['--e10s'], 10:50:52 INFO - 'tests': ['damp', 'tps']}, 10:50:52 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:50:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:50:52 INFO - 'other': {'tests': ['a11yr', 10:50:52 INFO - 'ts_paint', 10:50:52 INFO - 'tpaint', 10:50:52 INFO - 'sessionrestore', 10:50:52 INFO - 'sessionrestore_no_auto_restore']}, 10:50:52 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:50:52 INFO - 'tests': ['a11yr', 10:50:52 INFO - 'ts_paint', 10:50:52 INFO - 'tpaint', 10:50:52 INFO - 'sessionrestore', 10:50:52 INFO - 'sessionrestore_no_auto_restore']}, 10:50:52 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:50:52 INFO - 'tests': ['a11yr', 10:50:52 INFO - 'ts_paint', 10:50:52 INFO - 'tpaint', 10:50:52 INFO - 'sessionrestore', 10:50:52 INFO - 'sessionrestore_no_auto_restore']}, 10:50:52 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:50:52 INFO - 'tests': ['a11yr', 10:50:52 INFO - 'ts_paint', 10:50:52 INFO - 'tpaint', 10:50:52 INFO - 'sessionrestore', 10:50:52 INFO - 'sessionrestore_no_auto_restore']}, 10:50:52 INFO - 'other_l64': {'tests': ['a11yr', 10:50:52 INFO - 'ts_paint', 10:50:52 INFO - 'tpaint', 10:50:52 INFO - 'sessionrestore', 10:50:52 INFO - 'sessionrestore_no_auto_restore']}, 10:50:52 INFO - 'other_nol64': {'tests': ['a11yr', 10:50:52 INFO - 'ts_paint', 10:50:52 INFO - 'tpaint', 10:50:52 INFO - 'sessionrestore', 10:50:52 INFO - 'sessionrestore_no_auto_restore']}, 10:50:52 INFO - 'svgr': {'tests': ['tsvgx', 10:50:52 INFO - 'tsvgr_opacity', 10:50:52 INFO - 'tart', 10:50:52 INFO - 'tscrollx', 10:50:52 INFO - 'cart']}, 10:50:52 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:50:52 INFO - 'tests': ['tsvgx', 10:50:52 INFO - 'tsvgr_opacity', 10:50:52 INFO - 'tart', 10:50:52 INFO - 'tscrollx', 10:50:52 INFO - 'cart']}, 10:50:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:50:52 INFO - 'tests': ['tp5o']}, 10:50:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:50:52 INFO - 'talos_options': ['--e10s'], 10:50:52 INFO - 'tests': ['tp5o']}, 10:50:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:50:52 INFO - 'talos_options': ['--xperf_path', 10:50:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:50:52 INFO - 'tests': ['tp5n']}, 10:50:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:50:52 INFO - 'talos_options': ['--e10s', 10:50:52 INFO - '--xperf_path', 10:50:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:50:52 INFO - 'tests': ['tp5n']}}, 10:50:52 INFO - 'talos.zip': {'path': '', 10:50:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:50:52 INFO - Running post-action listener: _resource_record_post_action 10:50:52 INFO - ##### 10:50:52 INFO - ##### Running create-virtualenv step. 10:50:52 INFO - ##### 10:50:52 INFO - Running pre-action listener: _resource_record_pre_action 10:50:52 INFO - Running main action method: create_virtualenv 10:50:52 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 10:50:52 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 10:50:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 10:50:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:50:52 INFO - Using real prefix '/usr' 10:50:52 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 10:50:53 INFO - Installing distribute.............................................................................................................................................................................................done. 10:50:55 INFO - Installing pip.................done. 10:50:55 INFO - Return code: 0 10:50:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 10:50:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:50:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:50:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:50:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:50:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:55 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 0x7f331ef27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2810630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a1840>, '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 0x280e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x280eb60>, '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': 'ccb4611811c763f2fad71465000001de-1451326949.843446-1081295317', '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 10:50:55 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 10:50:55 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 10:50:55 INFO - Using env: {'DISPLAY': ':0', 10:50:55 INFO - 'HOME': '/home/cltbld', 10:50:55 INFO - 'LANG': 'en_US.UTF-8', 10:50:55 INFO - 'LANGUAGE': 'en_US:en', 10:50:55 INFO - 'LOGNAME': 'cltbld', 10:50:55 INFO - 'MAIL': '/var/mail/cltbld', 10:50:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:55 INFO - 'MOZ_NO_REMOTE': '1', 10:50:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:50:55 INFO - 'NO_EM_RESTART': '1', 10:50:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:50:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:50:55 INFO - 'PWD': '/builds/slave/test-pgo', 10:50:55 INFO - 'SHELL': '/bin/bash', 10:50:55 INFO - 'SHLVL': '1', 10:50:55 INFO - 'TERM': 'linux', 10:50:55 INFO - 'TMOUT': '86400', 10:50:55 INFO - 'USER': 'cltbld', 10:50:55 INFO - 'XDG_SESSION_COOKIE': 'ccb4611811c763f2fad71465000001de-1451326949.843446-1081295317', 10:50:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:55 INFO - '_': '/tools/buildbot/bin/python'} 10:50:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:50:55 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 10:50:55 INFO - Cleaning up... 10:50:55 INFO - Return code: 0 10:50:55 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 10:50:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:50:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:50:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:50:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:50:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:55 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 0x7f331ef27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2810630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a1840>, '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 0x280e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x280eb60>, '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': 'ccb4611811c763f2fad71465000001de-1451326949.843446-1081295317', '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 10:50:55 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 10:50:55 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 10:50:55 INFO - Using env: {'DISPLAY': ':0', 10:50:55 INFO - 'HOME': '/home/cltbld', 10:50:55 INFO - 'LANG': 'en_US.UTF-8', 10:50:55 INFO - 'LANGUAGE': 'en_US:en', 10:50:55 INFO - 'LOGNAME': 'cltbld', 10:50:55 INFO - 'MAIL': '/var/mail/cltbld', 10:50:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:55 INFO - 'MOZ_NO_REMOTE': '1', 10:50:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:50:55 INFO - 'NO_EM_RESTART': '1', 10:50:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:50:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:50:55 INFO - 'PWD': '/builds/slave/test-pgo', 10:50:55 INFO - 'SHELL': '/bin/bash', 10:50:55 INFO - 'SHLVL': '1', 10:50:55 INFO - 'TERM': 'linux', 10:50:55 INFO - 'TMOUT': '86400', 10:50:55 INFO - 'USER': 'cltbld', 10:50:55 INFO - 'XDG_SESSION_COOKIE': 'ccb4611811c763f2fad71465000001de-1451326949.843446-1081295317', 10:50:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:55 INFO - '_': '/tools/buildbot/bin/python'} 10:50:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:50:55 INFO - Downloading/unpacking psutil>=0.7.1 10:50:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:50:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:50:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:50:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:50:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:50:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:50:57 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 10:50:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 10:50:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 10:50:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:50:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:50:57 INFO - Installing collected packages: psutil 10:50:57 INFO - Running setup.py install for psutil 10:50:57 INFO - building 'psutil._psutil_linux' extension 10:50:57 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 10:50:57 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 10:50:57 INFO - building 'psutil._psutil_posix' extension 10:50:57 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 10:50:57 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 10:50:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:50:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:50:57 INFO - Successfully installed psutil 10:50:57 INFO - Cleaning up... 10:50:57 INFO - Return code: 0 10:50:57 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 10:50:57 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')]} 10:50:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:50:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:57 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')]} 10:50:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:50:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:57 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 0x7f331ef27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2810630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a1840>, '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 0x280e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x280eb60>, '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': 'ccb4611811c763f2fad71465000001de-1451326949.843446-1081295317', '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 10:50:57 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 10:50:57 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 10:50:57 INFO - Using env: {'DISPLAY': ':0', 10:50:57 INFO - 'HOME': '/home/cltbld', 10:50:57 INFO - 'LANG': 'en_US.UTF-8', 10:50:57 INFO - 'LANGUAGE': 'en_US:en', 10:50:57 INFO - 'LOGNAME': 'cltbld', 10:50:57 INFO - 'MAIL': '/var/mail/cltbld', 10:50:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:57 INFO - 'MOZ_NO_REMOTE': '1', 10:50:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:50:57 INFO - 'NO_EM_RESTART': '1', 10:50:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:50:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:50:57 INFO - 'PWD': '/builds/slave/test-pgo', 10:50:57 INFO - 'SHELL': '/bin/bash', 10:50:57 INFO - 'SHLVL': '1', 10:50:57 INFO - 'TERM': 'linux', 10:50:57 INFO - 'TMOUT': '86400', 10:50:57 INFO - 'USER': 'cltbld', 10:50:57 INFO - 'XDG_SESSION_COOKIE': 'ccb4611811c763f2fad71465000001de-1451326949.843446-1081295317', 10:50:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:57 INFO - '_': '/tools/buildbot/bin/python'} 10:50:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:50:58 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:50:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:50:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:50:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:50:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:50:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:50:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:50:59 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:50:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 10:50:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:50:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:50:59 INFO - Installing collected packages: mozsystemmonitor 10:50:59 INFO - Running setup.py install for mozsystemmonitor 10:50:59 INFO - Successfully installed mozsystemmonitor 10:50:59 INFO - Cleaning up... 10:50:59 INFO - Return code: 0 10:50:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 10:50:59 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')]} 10:50:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:50:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:59 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')]} 10:50:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:50:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:59 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 0x7f331ef27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2810630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a1840>, '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 0x280e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x280eb60>, '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': 'ccb4611811c763f2fad71465000001de-1451326949.843446-1081295317', '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 10:50:59 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 10:50:59 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 10:50:59 INFO - Using env: {'DISPLAY': ':0', 10:50:59 INFO - 'HOME': '/home/cltbld', 10:50:59 INFO - 'LANG': 'en_US.UTF-8', 10:50:59 INFO - 'LANGUAGE': 'en_US:en', 10:50:59 INFO - 'LOGNAME': 'cltbld', 10:50:59 INFO - 'MAIL': '/var/mail/cltbld', 10:50:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:59 INFO - 'MOZ_NO_REMOTE': '1', 10:50:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:50:59 INFO - 'NO_EM_RESTART': '1', 10:50:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:50:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:50:59 INFO - 'PWD': '/builds/slave/test-pgo', 10:50:59 INFO - 'SHELL': '/bin/bash', 10:50:59 INFO - 'SHLVL': '1', 10:50:59 INFO - 'TERM': 'linux', 10:50:59 INFO - 'TMOUT': '86400', 10:50:59 INFO - 'USER': 'cltbld', 10:50:59 INFO - 'XDG_SESSION_COOKIE': 'ccb4611811c763f2fad71465000001de-1451326949.843446-1081295317', 10:50:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:59 INFO - '_': '/tools/buildbot/bin/python'} 10:51:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:00 INFO - Downloading/unpacking blobuploader==1.2.4 10:51:00 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 10:51:00 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 10:51:00 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 10:51:00 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 10:51:00 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 10:51:00 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 10:51:01 INFO - Downloading blobuploader-1.2.4.tar.gz 10:51:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 10:51:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:51:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:51: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 10:51: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 10:51: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 10:51: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 10:51: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 10:51: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 10:51:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 10:51:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 10:51:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:51: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 10:51: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 10:51: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 10:51: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 10:51: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 10:51: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 10:51:02 INFO - Downloading docopt-0.6.1.tar.gz 10:51:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 10:51:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 10:51:02 INFO - Installing collected packages: blobuploader, requests, docopt 10:51:02 INFO - Running setup.py install for blobuploader 10:51:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:51:02 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 10:51:02 INFO - Running setup.py install for requests 10:51:02 INFO - Running setup.py install for docopt 10:51:03 INFO - Successfully installed blobuploader requests docopt 10:51:03 INFO - Cleaning up... 10:51:03 INFO - Return code: 0 10:51:03 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:51:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:51:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:51:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:03 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 0x7f331ef27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2810630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a1840>, '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 0x280e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x280eb60>, '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': 'ccb4611811c763f2fad71465000001de-1451326949.843446-1081295317', '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 10:51:03 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 10:51:03 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 10:51:03 INFO - Using env: {'DISPLAY': ':0', 10:51:03 INFO - 'HOME': '/home/cltbld', 10:51:03 INFO - 'LANG': 'en_US.UTF-8', 10:51:03 INFO - 'LANGUAGE': 'en_US:en', 10:51:03 INFO - 'LOGNAME': 'cltbld', 10:51:03 INFO - 'MAIL': '/var/mail/cltbld', 10:51:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:03 INFO - 'MOZ_NO_REMOTE': '1', 10:51:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:51:03 INFO - 'NO_EM_RESTART': '1', 10:51:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:51:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:51:03 INFO - 'PWD': '/builds/slave/test-pgo', 10:51:03 INFO - 'SHELL': '/bin/bash', 10:51:03 INFO - 'SHLVL': '1', 10:51:03 INFO - 'TERM': 'linux', 10:51:03 INFO - 'TMOUT': '86400', 10:51:03 INFO - 'USER': 'cltbld', 10:51:03 INFO - 'XDG_SESSION_COOKIE': 'ccb4611811c763f2fad71465000001de-1451326949.843446-1081295317', 10:51:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:03 INFO - '_': '/tools/buildbot/bin/python'} 10:51:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:51:03 INFO - Running setup.py (path:/tmp/pip-u9spws-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:51:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:51:03 INFO - Running setup.py (path:/tmp/pip-miPt5v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:51:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:51:03 INFO - Running setup.py (path:/tmp/pip-6dBFlh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:51:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:51:03 INFO - Running setup.py (path:/tmp/pip-cjLSbg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:51:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:51:03 INFO - Running setup.py (path:/tmp/pip-0WFUtS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:51:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:51:03 INFO - Running setup.py (path:/tmp/pip-f_Nc0a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:51:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:51:03 INFO - Running setup.py (path:/tmp/pip-uR0K8R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:51:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:51:03 INFO - Running setup.py (path:/tmp/pip-26KASN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:51:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:51:03 INFO - Running setup.py (path:/tmp/pip-pD1oR9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:51:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:51:04 INFO - Running setup.py (path:/tmp/pip-6Z3maD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:51:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:51:04 INFO - Running setup.py (path:/tmp/pip-xUoKhI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:51:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:51:04 INFO - Running setup.py (path:/tmp/pip-g_HpJV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:51:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:51:04 INFO - Running setup.py (path:/tmp/pip-XkeYi2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:51:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:51:04 INFO - Running setup.py (path:/tmp/pip-i6Hrxf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:51:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:51:04 INFO - Running setup.py (path:/tmp/pip-ropczL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:51:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:51:04 INFO - Running setup.py (path:/tmp/pip-MGMKAe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:51:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:51:04 INFO - Running setup.py (path:/tmp/pip-oUFEOi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:51:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:51:04 INFO - Running setup.py install for manifestparser 10:51:04 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 10:51:04 INFO - Running setup.py install for mozcrash 10:51:04 INFO - Running setup.py install for mozdebug 10:51:04 INFO - Running setup.py install for mozdevice 10:51:04 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 10:51:04 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 10:51:05 INFO - Running setup.py install for mozfile 10:51:05 INFO - Running setup.py install for mozhttpd 10:51:05 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 10:51:05 INFO - Running setup.py install for mozinfo 10:51:05 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 10:51:05 INFO - Running setup.py install for mozInstall 10:51:05 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 10:51:05 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 10:51:05 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 10:51:05 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 10:51:05 INFO - Running setup.py install for mozleak 10:51:05 INFO - Running setup.py install for mozlog 10:51:05 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 10:51:05 INFO - Running setup.py install for moznetwork 10:51:05 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 10:51:05 INFO - Running setup.py install for mozprocess 10:51:05 INFO - Running setup.py install for mozprofile 10:51:05 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 10:51:05 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 10:51:05 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 10:51:05 INFO - Running setup.py install for mozrunner 10:51:06 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 10:51:06 INFO - Running setup.py install for mozscreenshot 10:51:06 INFO - Running setup.py install for moztest 10:51:06 INFO - Running setup.py install for mozversion 10:51:06 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 10:51:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:51:06 INFO - Cleaning up... 10:51:06 INFO - Return code: 0 10:51:06 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:51:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:51:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:51:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:06 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 0x7f331ef27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2810630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a1840>, '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 0x280e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x280eb60>, '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': 'ccb4611811c763f2fad71465000001de-1451326949.843446-1081295317', '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 10:51:06 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 10:51:06 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 10:51:06 INFO - Using env: {'DISPLAY': ':0', 10:51:06 INFO - 'HOME': '/home/cltbld', 10:51:06 INFO - 'LANG': 'en_US.UTF-8', 10:51:06 INFO - 'LANGUAGE': 'en_US:en', 10:51:06 INFO - 'LOGNAME': 'cltbld', 10:51:06 INFO - 'MAIL': '/var/mail/cltbld', 10:51:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:06 INFO - 'MOZ_NO_REMOTE': '1', 10:51:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:51:06 INFO - 'NO_EM_RESTART': '1', 10:51:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:51:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:51:06 INFO - 'PWD': '/builds/slave/test-pgo', 10:51:06 INFO - 'SHELL': '/bin/bash', 10:51:06 INFO - 'SHLVL': '1', 10:51:06 INFO - 'TERM': 'linux', 10:51:06 INFO - 'TMOUT': '86400', 10:51:06 INFO - 'USER': 'cltbld', 10:51:06 INFO - 'XDG_SESSION_COOKIE': 'ccb4611811c763f2fad71465000001de-1451326949.843446-1081295317', 10:51:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:06 INFO - '_': '/tools/buildbot/bin/python'} 10:51:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:51:06 INFO - Running setup.py (path:/tmp/pip-LwYLfj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:51:06 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)) 10:51:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:51:06 INFO - Running setup.py (path:/tmp/pip-EuiWz7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:51:06 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)) 10:51:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:51:06 INFO - Running setup.py (path:/tmp/pip-vyvT6K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:51:06 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)) 10:51:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:51:06 INFO - Running setup.py (path:/tmp/pip-cY9b1e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:51:06 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)) 10:51:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:51:06 INFO - Running setup.py (path:/tmp/pip-aOh47o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:51:06 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)) 10:51:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:51:06 INFO - Running setup.py (path:/tmp/pip-4FEeZq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:51:07 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)) 10:51:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:51:07 INFO - Running setup.py (path:/tmp/pip-UGrBI2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:51:07 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)) 10:51:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:51:07 INFO - Running setup.py (path:/tmp/pip-ifR0Fs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:51:07 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)) 10:51:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:51:07 INFO - Running setup.py (path:/tmp/pip-MlI85d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:51:07 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)) 10:51:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:51:07 INFO - Running setup.py (path:/tmp/pip-OhYDH1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:51:07 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)) 10:51:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:51:07 INFO - Running setup.py (path:/tmp/pip-VJYRaj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:51:07 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)) 10:51:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:51:07 INFO - Running setup.py (path:/tmp/pip-nS1qOt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:51:07 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)) 10:51:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:51:07 INFO - Running setup.py (path:/tmp/pip-oOXL22-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:51:07 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)) 10:51:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:51:07 INFO - Running setup.py (path:/tmp/pip-GgZpYx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:51:07 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)) 10:51:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:51:07 INFO - Running setup.py (path:/tmp/pip-zYG9Rd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:51:07 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)) 10:51:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:51:07 INFO - Running setup.py (path:/tmp/pip-RpsHp9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:51:07 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)) 10:51:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:51:07 INFO - Running setup.py (path:/tmp/pip-_6Yjnn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:51:07 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)) 10:51:07 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)) 10:51:07 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)) 10:51:07 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)) 10:51:07 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)) 10:51:07 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)) 10:51:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 10:51:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:09 INFO - Downloading blessings-1.5.1.tar.gz 10:51:09 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 10:51:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 10:51:09 INFO - Installing collected packages: blessings 10:51:09 INFO - Running setup.py install for blessings 10:51:09 INFO - Successfully installed blessings 10:51:09 INFO - Cleaning up... 10:51:10 INFO - Return code: 0 10:51:10 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 10:51:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:51:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:51:10 INFO - Reading from file tmpfile_stdout 10:51:10 INFO - Current package versions: 10:51:10 INFO - argparse == 1.2.1 10:51:10 INFO - blessings == 1.5.1 10:51:10 INFO - blobuploader == 1.2.4 10:51:10 INFO - docopt == 0.6.1 10:51:10 INFO - manifestparser == 1.1 10:51:10 INFO - mozInstall == 1.12 10:51:10 INFO - mozcrash == 0.16 10:51:10 INFO - mozdebug == 0.1 10:51:10 INFO - mozdevice == 0.47 10:51:10 INFO - mozfile == 1.2 10:51:10 INFO - mozhttpd == 0.7 10:51:10 INFO - mozinfo == 0.9 10:51:10 INFO - mozleak == 0.1 10:51:10 INFO - mozlog == 3.1 10:51:10 INFO - moznetwork == 0.27 10:51:10 INFO - mozprocess == 0.22 10:51:10 INFO - mozprofile == 0.28 10:51:10 INFO - mozrunner == 6.11 10:51:10 INFO - mozscreenshot == 0.1 10:51:10 INFO - mozsystemmonitor == 0.0 10:51:10 INFO - moztest == 0.7 10:51:10 INFO - mozversion == 1.4 10:51:10 INFO - psutil == 3.1.1 10:51:10 INFO - requests == 1.2.3 10:51:10 INFO - wsgiref == 0.1.2 10:51:10 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:51: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')]} 10:51:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51: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')]} 10:51:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51: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 0x7f331ef27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2810630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a1840>, '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 0x280e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x280eb60>, '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': 'ccb4611811c763f2fad71465000001de-1451326949.843446-1081295317', '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 10:51: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 10:51: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 10:51:10 INFO - Using env: {'DISPLAY': ':0', 10:51:10 INFO - 'HOME': '/home/cltbld', 10:51:10 INFO - 'LANG': 'en_US.UTF-8', 10:51:10 INFO - 'LANGUAGE': 'en_US:en', 10:51:10 INFO - 'LOGNAME': 'cltbld', 10:51:10 INFO - 'MAIL': '/var/mail/cltbld', 10:51:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:10 INFO - 'MOZ_NO_REMOTE': '1', 10:51:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:51:10 INFO - 'NO_EM_RESTART': '1', 10:51:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:51:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:51:10 INFO - 'PWD': '/builds/slave/test-pgo', 10:51:10 INFO - 'SHELL': '/bin/bash', 10:51:10 INFO - 'SHLVL': '1', 10:51:10 INFO - 'TERM': 'linux', 10:51:10 INFO - 'TMOUT': '86400', 10:51:10 INFO - 'USER': 'cltbld', 10:51:10 INFO - 'XDG_SESSION_COOKIE': 'ccb4611811c763f2fad71465000001de-1451326949.843446-1081295317', 10:51:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:10 INFO - '_': '/tools/buildbot/bin/python'} 10:51:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:10 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)) 10:51:10 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)) 10:51:10 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)) 10:51:10 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)) 10:51:10 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)) 10:51:10 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)) 10:51:10 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)) 10:51:10 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)) 10:51:10 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)) 10:51:10 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)) 10:51:10 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)) 10:51:10 INFO - Cleaning up... 10:51:10 INFO - Return code: 0 10:51:10 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 10:51: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')]} 10:51:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51: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')]} 10:51:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51: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', '--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 0x7f331ef27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2810630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a1840>, '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 0x280e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x280eb60>, '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': 'ccb4611811c763f2fad71465000001de-1451326949.843446-1081295317', '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 10:51:10 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 10:51:10 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 10:51:10 INFO - Using env: {'DISPLAY': ':0', 10:51:10 INFO - 'HOME': '/home/cltbld', 10:51:10 INFO - 'LANG': 'en_US.UTF-8', 10:51:10 INFO - 'LANGUAGE': 'en_US:en', 10:51:10 INFO - 'LOGNAME': 'cltbld', 10:51:10 INFO - 'MAIL': '/var/mail/cltbld', 10:51:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:10 INFO - 'MOZ_NO_REMOTE': '1', 10:51:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:51:10 INFO - 'NO_EM_RESTART': '1', 10:51:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:51:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:51:10 INFO - 'PWD': '/builds/slave/test-pgo', 10:51:10 INFO - 'SHELL': '/bin/bash', 10:51:10 INFO - 'SHLVL': '1', 10:51:10 INFO - 'TERM': 'linux', 10:51:10 INFO - 'TMOUT': '86400', 10:51:10 INFO - 'USER': 'cltbld', 10:51:10 INFO - 'XDG_SESSION_COOKIE': 'ccb4611811c763f2fad71465000001de-1451326949.843446-1081295317', 10:51:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:10 INFO - '_': '/tools/buildbot/bin/python'} 10:51:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:10 INFO - Downloading/unpacking jsonschema 10:51:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:51:12 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 10:51:12 INFO - Downloading/unpacking functools32 (from jsonschema) 10:51:12 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 10:51:12 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 10:51:12 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 10:51:12 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 10:51:12 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 10:51:12 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 10:51:12 INFO - Downloading functools32-3.2.3-2.tar.gz 10:51:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 10:51:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 10:51:12 INFO - warning: no files found matching '*.txt' 10:51:12 INFO - no previously-included directories found matching 'build' 10:51:12 INFO - no previously-included directories found matching 'dist' 10:51:12 INFO - no previously-included directories found matching '.git*' 10:51:12 INFO - Installing collected packages: jsonschema, functools32 10:51:12 INFO - Running setup.py install for functools32 10:51:12 INFO - warning: no files found matching '*.txt' 10:51:12 INFO - no previously-included directories found matching 'build' 10:51:12 INFO - no previously-included directories found matching 'dist' 10:51:12 INFO - no previously-included directories found matching '.git*' 10:51:12 INFO - Successfully installed jsonschema functools32 10:51:12 INFO - Cleaning up... 10:51:12 INFO - Return code: 0 10:51:12 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 10:51:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:51:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:12 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f331ef27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2810630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a1840>, '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 0x280e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x280eb60>, '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': 'ccb4611811c763f2fad71465000001de-1451326949.843446-1081295317', '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 10:51:12 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 10:51:12 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 10:51:12 INFO - Using env: {'DISPLAY': ':0', 10:51:12 INFO - 'HOME': '/home/cltbld', 10:51:12 INFO - 'LANG': 'en_US.UTF-8', 10:51:12 INFO - 'LANGUAGE': 'en_US:en', 10:51:12 INFO - 'LOGNAME': 'cltbld', 10:51:12 INFO - 'MAIL': '/var/mail/cltbld', 10:51:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:12 INFO - 'MOZ_NO_REMOTE': '1', 10:51:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:51:12 INFO - 'NO_EM_RESTART': '1', 10:51:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:51:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:51:12 INFO - 'PWD': '/builds/slave/test-pgo', 10:51:12 INFO - 'SHELL': '/bin/bash', 10:51:12 INFO - 'SHLVL': '1', 10:51:12 INFO - 'TERM': 'linux', 10:51:12 INFO - 'TMOUT': '86400', 10:51:12 INFO - 'USER': 'cltbld', 10:51:12 INFO - 'XDG_SESSION_COOKIE': 'ccb4611811c763f2fad71465000001de-1451326949.843446-1081295317', 10:51:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:12 INFO - '_': '/tools/buildbot/bin/python'} 10:51:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:13 INFO - Downloading/unpacking flake8 10:51: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 10:51: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 10:51: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 10:51: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 10:51: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 10:51: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 10:51:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:51:14 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 10:51:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:51:14 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 10:51:14 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 10:51:14 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 10:51:14 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 10:51:14 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 10:51:14 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 10:51:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:51:14 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 10:51:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:51:14 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 10:51:14 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 10:51:14 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 10:51:14 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 10:51:14 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 10:51:14 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 10:51: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 10:51:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:51: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 10:51: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 10:51: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 10:51: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 10:51: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 10:51: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 10:51:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 10:51:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 10:51:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:51:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:51:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:51:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:51:15 INFO - no previously-included directories found matching 'docs/_build' 10:51:15 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:51:15 INFO - Running setup.py install for pep8 10:51:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:51:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:51:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:51:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:51:15 INFO - no previously-included directories found matching 'docs/_build' 10:51:15 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 10:51:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:51:15 INFO - Cleaning up... 10:51:15 INFO - Return code: 0 10:51:15 INFO - Running post-action listener: _resource_record_post_action 10:51:15 INFO - Running post-action listener: _start_resource_monitoring 10:51:15 INFO - Starting resource monitoring. 10:51:15 INFO - ##### 10:51:15 INFO - ##### Running install step. 10:51:15 INFO - ##### 10:51:15 INFO - Running pre-action listener: _resource_record_pre_action 10:51:15 INFO - Running main action method: install 10:51:15 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:51:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:51:15 INFO - Reading from file tmpfile_stdout 10:51:15 INFO - Detecting whether we're running mozinstall >=1.0... 10:51:15 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 10:51:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 10:51:15 INFO - Reading from file tmpfile_stdout 10:51:15 INFO - Output received: 10:51:15 INFO - Usage: mozinstall [options] installer 10:51:15 INFO - Options: 10:51:15 INFO - -h, --help show this help message and exit 10:51:15 INFO - -d DEST, --destination=DEST 10:51:15 INFO - Directory to install application into. [default: 10:51:15 INFO - "/builds/slave/test-pgo"] 10:51:15 INFO - --app=APP Application being installed. [default: firefox] 10:51:15 INFO - mkdir: /builds/slave/test-pgo/build/application 10:51:15 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'] 10:51:15 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 10:51:33 INFO - Reading from file tmpfile_stdout 10:51:33 INFO - Output received: 10:51:33 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 10:51:33 INFO - Running post-action listener: _resource_record_post_action 10:51:33 INFO - ##### 10:51:33 INFO - ##### Running run-tests step. 10:51:33 INFO - ##### 10:51:33 INFO - Running pre-action listener: _resource_record_pre_action 10:51:33 INFO - Running main action method: run_tests 10:51:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 10:51:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 10:51:33 INFO - Python 2.7.3 10:51:33 INFO - Return code: 0 10:51:33 INFO - grabbing minidump binary from tooltool 10:51: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')]} 10:51:33 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 0x28a1840>, '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 0x280e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x280eb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 10:51:33 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 10:51:33 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 10:51:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:51:33 INFO - Return code: 0 10:51:33 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 10:51:33 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 10:51:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 10:51:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 10:51:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 10:51:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 10:51:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 10:51:34 INFO - Return code: 0 10:51:34 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/7spQg9DMR0WB6z602ZU4Zg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 10:51:34 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/7spQg9DMR0WB6z602ZU4Zg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-021 --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 10:51:34 INFO - Using env: {'DISPLAY': ':0', 10:51:34 INFO - 'HOME': '/home/cltbld', 10:51:34 INFO - 'LANG': 'en_US.UTF-8', 10:51:34 INFO - 'LANGUAGE': 'en_US:en', 10:51:34 INFO - 'LOGNAME': 'cltbld', 10:51:34 INFO - 'MAIL': '/var/mail/cltbld', 10:51:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:51:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 10:51:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:34 INFO - 'MOZ_NO_REMOTE': '1', 10:51:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:51:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:51:34 INFO - 'NO_EM_RESTART': '1', 10:51:34 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:51:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:51:34 INFO - 'PWD': '/builds/slave/test-pgo', 10:51:34 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 10:51:34 INFO - 'SHELL': '/bin/bash', 10:51:34 INFO - 'SHLVL': '1', 10:51:34 INFO - 'TERM': 'linux', 10:51:34 INFO - 'TMOUT': '86400', 10:51:34 INFO - 'USER': 'cltbld', 10:51:34 INFO - 'XDG_SESSION_COOKIE': 'ccb4611811c763f2fad71465000001de-1451326949.843446-1081295317', 10:51:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:34 INFO - '_': '/tools/buildbot/bin/python'} 10:51:34 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/7spQg9DMR0WB6z602ZU4Zg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 10:51:34 INFO - mozversion application_buildid: 20151228083140 10:51:34 INFO - mozversion application_changeset: 5b9292b9f878471b54498c1a70cecb76d5a409b3 10:51:34 INFO - mozversion application_display_name: Nightly 10:51:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:51:34 INFO - mozversion application_name: Firefox 10:51:34 INFO - mozversion application_remotingname: firefox 10:51:34 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:51:34 INFO - mozversion application_vendor: Mozilla 10:51:34 INFO - mozversion application_version: 46.0a1 10:51:34 INFO - mozversion platform_buildid: 20151228083140 10:51:34 INFO - mozversion platform_changeset: 5b9292b9f878471b54498c1a70cecb76d5a409b3 10:51:34 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:51:34 INFO - mozversion platform_version: 46.0a1 10:51:34 INFO - using testdate: 1451328694 10:51:34 INFO - actual date: 1451328694 10:51:34 INFO - starting webserver on 'localhost:41364' 10:51:34 INFO - SUITE-START | Running 3 tests 10:51:34 INFO - TEST-START | dromaeo_css 10:51:34 INFO - operating with platform_type : linux_ 10:51:34 INFO - Initialising browser for dromaeo_css test... 10:51:34 INFO - TEST-INFO | started process 14612 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpTIc_Lz/profile http://localhost:41364/getInfo.html) 10:51:39 INFO - PROCESS | 14612 | __metrics Screen width/height:1600/1200 10:51:39 INFO - PROCESS | 14612 | colorDepth:24 10:51:39 INFO - PROCESS | 14612 | Browser inner width/height: 1024/697 10:51:39 INFO - PROCESS | 14612 | __metrics 10:51:39 INFO - PROCESS | 14612 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 10:51:40 INFO - PROCESS | 14612 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:51:41 INFO - TEST-INFO | 14612: exit 0 10:51:41 INFO - Browser initialized. 10:51:41 INFO - Running cycle 1/1 for dromaeo_css test... 10:51:41 INFO - TEST-INFO | started process 14704 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpTIc_Lz/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:51:53 INFO - PROCESS | 14704 | RSS: Main: 148303872 10:51:53 INFO - PROCESS | 14704 | 10:52:43 INFO - PROCESS | 14704 | 1451328763773 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] 10:54:53 INFO - PROCESS | 14704 | Cycle 1(1): loaded http://localhost:41364/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41364/tests/dromaeo/cssquery-ext.html) 10:54:55 INFO - PROCESS | 14704 | RSS: Main: 328818688 10:54:55 INFO - PROCESS | 14704 | 10:57:57 INFO - PROCESS | 14704 | Cycle 1(1): loaded http://localhost:41364/tests/dromaeo/cssquery-ext.html (next: http://localhost:41364/tests/dromaeo/cssquery-jquery.html) 10:57:58 INFO - PROCESS | 14704 | RSS: Main: 235552768 10:57:58 INFO - PROCESS | 14704 | 11:01:00 INFO - PROCESS | 14704 | Cycle 1(1): loaded http://localhost:41364/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41364/tests/dromaeo/cssquery-mootools.html) 11:01:00 INFO - PROCESS | 14704 | RSS: Main: 223109120 11:01:00 INFO - PROCESS | 14704 | 11:04:02 INFO - PROCESS | 14704 | Cycle 1(1): loaded http://localhost:41364/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41364/tests/dromaeo/cssquery-prototype.html) 11:04:03 INFO - PROCESS | 14704 | RSS: Main: 211787776 11:04:03 INFO - PROCESS | 14704 | 11:07:05 INFO - PROCESS | 14704 | Cycle 1(1): loaded http://localhost:41364/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41364/tests/dromaeo/cssquery-yui.html) 11:07:06 INFO - PROCESS | 14704 | RSS: Main: 216510464 11:07:06 INFO - PROCESS | 14704 | 11:10:08 INFO - PROCESS | 14704 | Cycle 1(1): loaded http://localhost:41364/tests/dromaeo/cssquery-yui.html (next: http://localhost:41364/tests/dromaeo/cssquery-dojo.html) 11:10:09 INFO - PROCESS | 14704 | RSS: Main: 274735104 11:10:09 INFO - PROCESS | 14704 | 11:10:09 INFO - PROCESS | 14704 | __start_tp_report 11:10:09 INFO - PROCESS | 14704 | _x_x_mozilla_page_load 11:10:09 INFO - PROCESS | 14704 | _x_x_mozilla_page_load_details 11:10:09 INFO - PROCESS | 14704 | |i|pagename|runs| 11:10:09 INFO - PROCESS | 14704 | |0;dojo.html;3137.372525494901;3193.936121277576;3241.7082462578364;3253.024092772168;3273.3944220319236;5180.222966555009;5283.735813209339;5293;5303.204519322094;5339.893202135955;5195.532402083812;5291.947080529194;5321.627486075976;5373.167159090338;5379.193121031847;4779.880502987418;4808.687435316702;4873.415190177184;4911.214205727084;4943.357363542735;4869.659123861331;4890.119778439879;4902.901941961159;4967.0810899983435;4973.254011898208;4730.314104454852;4753.904921901577;4821.90356192876;4823.927641085386;4832.395950506187;4820.831270905502;4820.855374338776;4823.276508523714;4828.275758636198;4853.757312134379;4704.623630109583;4787.497312782178;4794.137055330039;4815.975920120412;4827.879303017417;5016.247562865563;5038.7984480620735;5119.744012799345;5128.948710512885;5164.612654050924;5728;5733.312002559678;5736.4550367715;5746.310442746855;5747.39652336507;5600.831975040755;5715.942840571583;5757.136429535562;5770.105633626795;5771.653700777967;5282.867928301785;5296.761645725952;5340.626156169031;5347.41178470368;5370.006548788487;5789.681567513827;5794.304683438015;5797.159411885253;5808.128780682931;5808.244928159397;5421.972890135524;5514.834554963358;5590.664560126405;5600.411956744565;5601.747921343549;5623.775048998076;5711.857203569944;5740.54075673945;5750.884982300414;5800.361960184377;5660.066089095253;5694.829155125353;5699.572532060112;5711.6001879868845;5720.11338242573;5578;5673.517750991212;5695.658260504383;5696.088625819849;5699.373068962411;4303.505096913832;4365.890852728708;4370.409994650745;4371.038371558252;4408.58118478744;3927.8036098194975;3932.075962148893;3949.7037722170376;3975.602439756059;4003.2193722223888;5126.871828204325;5213.400458947193;5317.654352467077;5322.654027488201;5372.059889519319;5651.943480565224;5673.375928647845;5782.219400380979;5789.131630255495;5801.6519008859605;5307.124324486494;5307.177387504943;5308.442613525602;5313.388960269618;5318.97340513295;4891.828785992473;4923.729194894244;4923.90152196954;4935.777889994887;4969.229769385751;5715.399883012307;5760.452756988163;5801.3038435388025;5809.564282678816;5905.616134951214;5683.943160568341;5705.429457054262;5711.485966263056;5711.543076553949;5746.655200687972;5862.824115276549;5866.266716660418;5868.559858010752;5869.618474799125;5872.882542349214;5420.783168673209;5510.448955104618;5573.749181286771;5613.943860561505;5696.316442026983;5696.629719068247;5723.885522289447;5726.770929162787;5734.598578099493;5735.684537350486;5582.916256256241;5588.776448941997;5589.161625756169;5589.301337332833;5595.300587426572;5356.517913387814;5518.696471694096;5520.641158324696;5522.420145884625;5522.9447705524035;5343.7595308212;5347.0375332440535;5347.144456886879;5348.705821179872;5351.759170837399;5439.401665816836;5445.700486473282;5450.155225939986;5543.1408131739645;5577.414371490935;5427.3215848019;5478.534324582455;5482.890342193214;5483.588730845123;5511.22842802016 11:10:09 INFO - PROCESS | 14704 | |1;ext.html;551.8494281277166;584.9354175400767;590.7932223721698;592.6088781404274;597.6742675241993;27513.174604761865;35708.821455892714;35797;35797.46303805445;35830.82084589577;38325.61674383255;38901;38905.22189556207;38911;38974.415383769265;7527.811804704899;7562.395008399315;7585.393168546503;8443.197896199867;8689;10009.649662261822;10108;10170.084692377684;10171.186305095574;10176.135028522585;10069.798604027916;10114.2414318926;10171.694849154537;10178.796424071514;10187.134093602053;7608.885866712004;7687.0391201099865;7689.19263477338;9998.45008524531;10201;9872.45701486418;10005.19958403326;10010.799784004352;10017;10019.098281154731;36609.08477288089;37019.4447083294;37045.25909481795;37061.70284040046;37140.25719485595;2997.67025627183;3032.438998785232;3092.273315770792;3120.60992375953;3148.071318960912;30728.692713072807;31167.53248701271;31392;31513.21216969594;31730;2965.066004208689;2996.625421822272;3004.5943797587483;3025.4705426550267;3122.2350524121507;207620;209501;209886;210947.452627368;211413;52355;52861.12805335359;53927.460725392244;54764.178537321975;59426;54862;55018.72490637521;55269.17096243559;55365;55488.72255638696;13117.0818042738;13153.21080735159;13194.47222111124;13229.603111906657;13238.53665121716;10916.399598022184;10964.56141754321;10983.890161098287;10993.230473866912;10993.670189894316;18715.532111697044;18842.71735923962;19413.51466213328;19657.311994080137;19777.30779422742;7785.221477852169;7935.563544005136;8029.237222463857;8033.3974951878845;8082.636281367235;916.225789208118;1005.7234260578399;1028.5165971993151;1057.349729916096;1060.2419270221674;28863.134105976853;28879;29224.707752922623;29336.559951600742;30491.390172196432;1002.7242508310273;1006.8590397344377;1007.652359935821;1026.1329176845554;1084.5336505302637;13813.102148360324;13821.170729756246;14307.85692143086;14572;15757.763633545506;381406;387043;387094;387884;388037;54232;54587;54790;54820.72589637026;54900.45099549033;1345.5156143788229;1345.7039451320693;1351.9188848668914;1393.9024268301325;1486.7695507196402;25226.102685403646;27483;30457.390852183275;31689.524657130623;32033.839830800698;47798.56604301876;48428.51571484381;48465;48526.75736621294;48527;296217;298238;298288;298621;392600;27791.58312625353;30899.382012360078;31020.379592408477;31212.687873120976;31496.527552086278;36111;37229.81385093057;37372.81313593415;37540.43689344607;37610.2477950434;32480.512792308607;33738;33925;34194;34590.30819383548;32968.175795605304;34002.829985849916;34006;34046;34280.14299642529;32936.67063329336;33679.32641347208;33908.321833562695;33918.321633566695;33931.321373572886;27669.53812772786;30515.237119071313;35025.82487087548;36983.63016369802;37562.624373757004;24442.26673199807;24598.139065132633;24668;24781.752182477943;24846 11:10:09 INFO - PROCESS | 14704 | |2;jquery.html;342.3375767889134;342.92627085176684;343.0737010072803;344.767282084593;354.75521889895987;13990.090644108126;14387.78418323726;15835.366585336587;16293.918530407345;17295.394661186845;16259.105749183791;16342.509724708249;16556.50330490087;16870.325186992537;16915.91542042288;5229.764660590264;5357.383900851393;5357.866053348678;5363.222332761748;5368.62419630626;3939.665128464084;4050.0077481017192;5302.946970530304;5893.793717219876;6030.939690603103;5932.881342373172;5961.314448838374;5964.850878728023;5989.670568118751;5992.700364981733;5777.133429985514;5916.5266778657815;5917.55618328627;5919.467247947662;5924.3483216846325;5148.297692039266;5165.63840531163;5196.324477817897;5209.53114219722;5211.0359583477175;20146.294879679288;20159.89920050405;20280.89859550693;21180.258690945742;21220.575588488296;2158.881261530615;2183.5087105401317;2228.0308065991344;2246.606843802328;2635.4333818229175;12591.622251332476;12738.363081845871;12909.160904541175;13120.60638180856;13612.31938403076;1769.5222289981632;1793.9372121975798;1800.4778614201996;1814.3468351393487;1831.8259765322407;59599.70200148971;61669.074963876024;62261;62767;63930.360696392905;10058.798824023479;10094.697159085239;10126.696199114038;10144.529043288681;10151.289409741246;13287.800682989762;13357.265350405822;13387.866121338662;13389;13394.464221431228;6973.825654358681;7040.225575186725;7115.89326160108;7206.7117315306805;7247.637618119178;6877.552959057645;6887.380135787703;6894.758683446055;6968.163820341591;6970.477214208955;4275.3112520554205;4298.312270036779;4308.655307575386;4342.891427714332;4348.326009468537;1669.2321532095373;1717.0985232752905;1724.9650209873976;1789.973150402745;1797.5595978985232;875.4572165257454;893.8748575199347;955.1833182628891;960.1742501448748;993.9861341431699;14539.927300363643;15929.203539822962;16737.665246694996;16785.748213776802;17097.145142742815;861.2550144125287;893;905.456725964416;906.5512571277128;943.9292053096045;8625.482471051631;8817.338699597556;8840.690575829814;8884.466931984101;8996.370254082152;582381;589634;593514;608935;616021;82726;85827.14172858317;85982;86211.56894215489;86946;1105.8230683090828;1110.7389763405592;1117.1398023521842;1122.141561705296;1123.5786580032488;14336.56990290293;14463.27683615794;14597.854021460074;14709.117452952856;14753.92623036878;27377;33812;34225.315493689486;36583.634163658025;37257.62742372542;44805.32792008057;45533.31700024568;45972;47861;48351;9352.766180845534;9564.13922746956;9594;9598.232141428529;9620.807583848424;11258.887411126112;12389.62831115068;14044.297785110908;17574.64850702953;17927.551811204823;11693.064554835762;13535.120217185851;13626.727465450835;13740.587782366545;13820.308984550933;13305.467781289028;13976.301184940508;14032.508862189774;14044.438222470986;14397.856021440071;13983.650408739863;14044.648883777578;14134.858651413355;14256.50102246458;14309.068275782636;9270.072992700676;9343.392679475812;9447.385919915183;9452.669156579486;9549.809003820024;12796.744065118459;13461.057725959088;14454.927725361305;14543.92728036353;14762.926185369004 11:10:09 INFO - PROCESS | 14704 | |3;mootools.html;1338.668025314812;1424.3661570601084;1426.0944300369265;1560.890737648365;1755.0698129991108;6444.677766111693;7028.543144695597;7098.574085554864;7115.466340024493;7126.14486261648;7065.328793764585;7202.2077571467225;7220.0613920190435;7230.674619642115;7235.67439465224;1908.9045547722558;1938.8158124978174;2129;2158.719366482359;2195.3962660268394;2241.652543855697;2249.640057590786;2252.549490101978;2273.715785526809;2274.7725227477285;2155.1164022750677;2229.1194977983687;2229.565234779219;2230.130249202812;2231.631780756173;2168.165256376291;2194.5391467791783;2210.767869373725;2219.2010876084596;2222.6666000100035;2208.878511681873;2235.552889422122;2236.463248820288;2238.2613737466595;2239.496113374494;7192.4246060315045;7280.672369743322;7297;7297.744578939764;7298.9635051824935;4419.734815911055;4520.050789334244;4524.2082635538645;4574.290984897346;4579.748113853737;2769.709180536055;2826.4488424757183;2838.886444542216;2854.985725071382;2919.722626350493;894.3381897395881;917.1974522292994;920.6133423961952;923.3259720404143;1731.2901710298718;9500.524973751284;9630.036996300454;9647.855282170773;9660.71017869465;9665.806683866354;3865.1496670732395;3930.7838068906485;3953.604639536081;3953.8418463261723;3996.6403023728003;8188.50868947865;8191.918080819116;8192.221738934792;8199.262066414052;8229.506229626242;4410.867673969786;4416.933745993812;4427.535108813592;4433.7118087324225;4469.463664360298;4038.293298672779;4058.1072164123843;4063.146739184745;4065.6950728695465;4070.2266569351727;3098.3648352087766;3126.9530957035663;3233.6766323367947;3448.5689288838894;3506.1409954561295;1128.537299707116;1141.3380239461092;1149.1383957988112;1151.159653452984;1152.7175841918784;1013.9442330671884;1023.4064242739194;1069.053887309721;1087.2389327470803;1317.0122408193854;6675.833104172338;6717.361850624183;6739.427148692416;6742.528023038439;6750.088738020305;1016.2581315639625;1024.4877561219391;1039.5633833789827;1092.2190633696787;1092.3282181458505;5496.725163741797;5544.91682624761;5563.777448902079;5565.1374037024325;5566.276384070045;8500.617472213766;8656.913430865736;8839.425437346552;8866.911330886738;8933.59798809055;8719.694810681596;8743.737687869247;8797.208251257418;8820.470771753715;8837.734867953972;6610.206775187008;6774.932250677529;6790.7283708652085;6992.825179370455;7040.014397984286;6672.6997285121315;6703.262641109572;6737.258901520927;6738.225104113089;6740.764073257413;7504.061992250969;7852.803679907819;7858.214178582325;7859.253370929752;7861.292483676497;7801.648925798239;7963.562004089831;7965.163657815846;7966.482178658369;8071.757847264592;6289.276733175743;6351.30135685065;6355.586886852339;6357.650329231937;6466.030095485715;6265.248170219421;6366.267879193767;6730.192376914802;6826.795196144124;6843.931560684329;6342.334054924167;6372.6495042773095;6400.615963042046;6437.839054023687;6570.934290657032;6300.621962682254;6393.1369265148605;6440.194975628046;6472.223333200046;6518.152640156749;6362.395572420613;6395.392437718409;6396.776112836028;6400.807975760735;6401.967990160019;5816.447437493432;5841.773227622247;5858.121281807763;5929.673867937132;5951.940480595139;5863.061910094364;5899.587028907935;5905.940940590711;5925.4370834770625;5931.525477961839 11:10:09 INFO - PROCESS | 14704 | |4;prototype.html;313.373253493014;313.67691277983675;313.8054406268114;317.21331098874776;318.4284209843331;5876.0598304271325;5929.614575052618;6047.304559975604;6052.42501962314;6071.301800292957;5886.440788125132;5933.288005439343;5938.0795976623585;5948.553858460622;5953.553483488734;4541.523140070294;4551.5676010778925;4552.704074235181;4555.544445555434;4561.635069194473;4333.566643335673;4506.076254367863;4552.772361381918;4558.133954548625;4560.543945605446;4423;4430.822767089313;4436.423264975549;4437.267850804614;4443.866683999485;4431.202383570956;4433.401490798733;4442.511323754385;4447;4450.198964186461;3717.981410092932;3805.714571407128;3820.6943444524372;3880.844766209348;3893.396523538856;5670.659760414347;5671.801486947937;5672.40439753824;5673.971630141864;5677.261955945701;4960.553550180465;5120.15517439622;5207.817726379596;5215.3741551013745;5216.3218781558535;6136.171616831715;6256.530760192958;6276.87446251077;6283.591566548205;6307.4954003679595;4183.6653067754505;4185.2885009548145;4186.727862688946;4190.329547272422;4194.475690538683;6523.967380163116;6604.108445359863;6616.569922955041;6617.86764264712;6623;4236.368997935817;4336.154449882242;4337.891552711208;4338.848140315137;4346.282863327516;4341.283688191476;4393.055493069006;4396.07682386696;4396.538363471854;4396.934045989313;5121.743912804345;5122.92315615266;5139.8458046258675;5144.511271429208;5147.124988751922;6215.409536094155;6380.138681278061;6384.776532821329;6390.712417941204;6394.360563943568;1554.2306558253738;1587.5237428771554;1587.8809089318347;1590.7295759720876;1591.1407839766396;1020.1023099672241;1026.7689769801734;1029.4286670897575;1037.1288117980932;1045.6810672744887;6057.697115144313;6117;6119.908201376983;6120.051392034242;6121.908171377433;6569.113169722122;6572.07990881277;6574.3754343337305;6581.2102547694585;6584.539082264291;6026.487748541423;6029.939700603026;6039.245094363205;6045.78839740607;6047.697615119227;3453.5855697316483;3544.3974524330924;3547.69844563215;3549.751517393809;3552.200754830194;6820.727170913207;6839.076724642209;6860.588364698134;6862.519623626398;6864.141982252218;6740.224874139439;6741.52809303344;6747.426468750113;6752.054712340277;6752.324767523307;6704.2625311215725;6832.521723479408;6862.769599880059;6868.278830722702;6887.5178737488895;6582.506312026713;6598.934010660024;6625;6631.071649969104;6632.469402447696;6420.101185833893;6555.6066636002;6563.901541476786;6565.606063636197;6569.178852643419;6847.965760171167;6850.691718872563;6858.5199036067;6858.965705171442;6862.725490980305;4467.285234362486;4489.461264648263;4489.663275254304;4490.506044335055;4494.056248187917;6636.435902948304;6641.402273795382;6645.368689974444;6648.5678430901835;6655.633940133339;6267.467265282502;6449.871002579828;6450.741970321323;6461.709223085067;6466.579672321284;6421.165248517663;6421.8073457796345;6422.068800024063;6426.228852537725;6440.484761218998;6162.403556689769;6315.778947736807;6324.747010119728;6326.493880489642;6330.240371155491;6447.807155676215;6455.709493072729;6458.257300410325;6464.8707025858275;6475.935240647534;6315.052742088724;6317.115603815378;6325.905111423241;6330.968345158245;6341.714622841891 11:10:09 INFO - PROCESS | 14704 | |5;yui.html;727.0511981863667;784.6743601405417;797.9162187970263;835.9456635318704;843.6414523827372;13197.868021319784;13600.183988960656;13609.047366684335;13632.591022269324;13638.522651707191;14132.57602271931;14137.293135343243;14270.215138167398;14284.21436820977;14287;690.7340673840582;697.3340459860846;815.7226542975387;819.7704642700023;828.8342331533687;819.4141189049828;826.9297109745679;832.3507664022072;832.5753865528594;832.9250367466926;853.9658413663446;855.4567849415635;858.8883445152153;859.3383095016833;860.3547339495378;720.4560556779624;727.1928159742681;859.8452278589851;870.8693695945595;872.8734333521668;637.0412529143656;637.7895294552833;639.9168108145958;640.014377858098;640.6028262477247;13063.542776002794;13160.341982900816;13211.933940330333;13219.20684758908;13224.27266500342;11295;11813;11948.402579870972;12384.690382740413;12648.320121555083;10022.198224142052;10214.642487512976;10252;10291.948540257326;10426.635067772668;3559.483874838134;3633.182533929845;3673.797941113238;3742.700583953277;3766.9811650941842;46522.5347746525;46890;47057.294140587575;47365;47365.76317118427;9382.483963381943;9441.858372124423;9753.804923901482;9813.460259685644;9968.152707019985;18255;18455.630887382176;18467.907660461613;18515.166817493246;18547.165377557772;7106.942660573225;7240.094988126484;7259.818504537428;7281.927180728231;7367.705291788268;3832.80835958201;3924.9803750981064;3941.231459865299;4033.4756481657782;4078.9592104079175;3073.354595534918;3095.8297293648616;3100.891468798581;3105.2857842695853;3124.703153200442;521.8930119325529;545.5826292885945;548.4131978782664;548.9286392768914;565.5249590344131;553.1923391847947;572.1793886506169;584.3513699793226;598.470906833037;613.555172499943;7542.547447153188;7691.5385076894445;7704.768856934301;7799.3760499159935;7854.72508462201;566.1705601294124;602.4878852975024;614.1708693264058;626.0515319291277;636.78667646339;3379.543761592203;3608.855645774192;3713.1459764254373;3743.1390780120723;3752.6434988676033;52221;53136.73431632817;57358.42641573615;57835.710821445624;57899.710501447225;45005;45545.54454455413;45824.08351832945;48107;53163.46836531663;47207;47886.521134788905;47897.52102479;48036.7598162007;48375.5162448378;7968.601569921597;8221.630026648696;8364.574273460872;8371.372147089114;8659.653613855628;35376.469352960245;35931.56273749125;36018.09954751152;36630.63369366272;36925.446118308784;44817.551824481336;47069.16705797708;47351.76324118357;47672;48190.759046205945;9819.16537094355;9882.752931176778;10282.948585257025;10441.269111162146;10492.685219443429;11500.367479788358;11637.941810291233;11643.184977051525;12026.518939242333;12041.75916481648;11390.943045284721;11438.256513326607;11532.308061516336;11637.359945202756;11936.820947685965;11375.20373573875;11565.884341156481;11593.24643898144;11755.294682319089;11957.461914214055;10792;10888.29226100301;10996.505157268102;11045.834312485158;11413.771724565628;9364.953175234352;9449.338546301693;9609.759756006155;9639.421634701941;9770.267229957924;8840.734777956672;9573.473458959825;9714.465704386326;9763.316567840184;9820.950895245478 11:10:09 INFO - PROCESS | 14704 | __end_tp_report 11:10:09 INFO - PROCESS | 14704 | __start_cc_report 11:10:09 INFO - PROCESS | 14704 | _x_x_mozilla_cycle_collect,1645 11:10:09 INFO - PROCESS | 14704 | __end_cc_report 11:10:09 INFO - PROCESS | 14704 | __startTimestamp1451329809076__endTimestamp 11:10:09 INFO - PROCESS | 14704 | 11:10:09 INFO - PROCESS | 14704 | ------- Summary: start ------- 11:10:09 INFO - PROCESS | 14704 | Number of tests: 6 11:10:09 INFO - PROCESS | 14704 | 11:10:09 INFO - PROCESS | 14704 | [#0] dojo.html Cycles:165 Average:5271.30 Median:5421.97 stddev:574.89 (10.6%) stddev-sans-first:551.74 11:10:09 INFO - PROCESS | 14704 | Values: 3137.4 3193.9 3241.7 3253.0 3273.4 5180.2 5283.7 5293.0 5303.2 5339.9 5195.5 5291.9 5321.6 5373.2 5379.2 4779.9 4808.7 4873.4 4911.2 4943.4 4869.7 4890.1 4902.9 4967.1 4973.3 4730.3 4753.9 4821.9 4823.9 4832.4 4820.8 4820.9 4823.3 4828.3 4853.8 4704.6 4787.5 4794.1 4816.0 4827.9 5016.2 5038.8 5119.7 5128.9 5164.6 5728.0 5733.3 5736.5 5746.3 5747.4 5600.8 5715.9 5757.1 5770.1 5771.7 5282.9 5296.8 5340.6 5347.4 5370.0 5789.7 5794.3 5797.2 5808.1 5808.2 5422.0 5514.8 5590.7 5600.4 5601.7 5623.8 5711.9 5740.5 5750.9 5800.4 5660.1 5694.8 5699.6 5711.6 5720.1 5578.0 5673.5 5695.7 5696.1 5699.4 4303.5 4365.9 4370.4 4371.0 4408.6 3927.8 3932.1 3949.7 3975.6 4003.2 5126.9 5213.4 5317.7 5322.7 5372.1 5651.9 5673.4 5782.2 5789.1 5801.7 5307.1 5307.2 5308.4 5313.4 5319.0 4891.8 4923.7 4923.9 4935.8 4969.2 5715.4 5760.5 5801.3 5809.6 5905.6 5683.9 5705.4 5711.5 5711.5 5746.7 5862.8 5866.3 5868.6 5869.6 5872.9 5420.8 5510.4 5573.7 5613.9 5696.3 5696.6 5723.9 5726.8 5734.6 5735.7 5582.9 5588.8 5589.2 5589.3 5595.3 5356.5 5518.7 5520.6 5522.4 5522.9 5343.8 5347.0 5347.1 5348.7 5351.8 5439.4 5445.7 5450.2 5543.1 5577.4 5427.3 5478.5 5482.9 5483.6 5511.2 11:10:09 INFO - PROCESS | 14704 | 11:10:09 INFO - PROCESS | 14704 | [#1] ext.html Cycles:180 Average:46550.52 Median:17322.30 stddev:82570.97 (476.7%) stddev-sans-first:82730.37 11:10:09 INFO - PROCESS | 14704 | Values: 551.8 584.9 590.8 592.6 597.7 27513.2 35708.8 35797.0 35797.5 35830.8 38325.6 38901.0 38905.2 38911.0 38974.4 7527.8 7562.4 7585.4 8443.2 8689.0 10009.6 10108.0 10170.1 10171.2 10176.1 10069.8 10114.2 10171.7 10178.8 10187.1 7608.9 7687.0 7689.2 9998.5 10201.0 9872.5 10005.2 10010.8 10017.0 10019.1 36609.1 37019.4 37045.3 37061.7 37140.3 2997.7 3032.4 3092.3 3120.6 3148.1 30728.7 31167.5 31392.0 31513.2 31730.0 2965.1 2996.6 3004.6 3025.5 3122.2 207620.0 209501.0 209886.0 210947.5 211413.0 52355.0 52861.1 53927.5 54764.2 59426.0 54862.0 55018.7 55269.2 55365.0 55488.7 13117.1 13153.2 13194.5 13229.6 13238.5 10916.4 10964.6 10983.9 10993.2 10993.7 18715.5 18842.7 19413.5 19657.3 19777.3 7785.2 7935.6 8029.2 8033.4 8082.6 916.2 1005.7 1028.5 1057.3 1060.2 28863.1 28879.0 29224.7 29336.6 30491.4 1002.7 1006.9 1007.7 1026.1 1084.5 13813.1 13821.2 14307.9 14572.0 15757.8 381406.0 387043.0 387094.0 387884.0 388037.0 54232.0 54587.0 54790.0 54820.7 54900.5 1345.5 1345.7 1351.9 1393.9 1486.8 25226.1 27483.0 30457.4 31689.5 32033.8 47798.6 48428.5 48465.0 48526.8 48527.0 296217.0 298238.0 298288.0 298621.0 392600.0 27791.6 30899.4 31020.4 31212.7 31496.5 36111.0 37229.8 37372.8 37540.4 37610.2 32480.5 33738.0 33925.0 34194.0 34590.3 32968.2 34002.8 34006.0 34046.0 34280.1 32936.7 33679.3 33908.3 33918.3 33931.3 27669.5 30515.2 35025.8 36983.6 37562.6 24442.3 24598.1 24668.0 24781.8 24846.0 11:10:09 INFO - PROCESS | 14704 | 11:10:09 INFO - PROCESS | 14704 | [#2] jquery.html Cycles:180 Average:30521.34 Median:343.92 stddev:97773.30 (28429.0%) stddev-sans-first:98021.31 11:10:09 INFO - PROCESS | 14704 | Values: 342.3 342.9 343.1 344.8 354.8 13990.1 14387.8 15835.4 16293.9 17295.4 16259.1 16342.5 16556.5 16870.3 16915.9 5229.8 5357.4 5357.9 5363.2 5368.6 3939.7 4050.0 5302.9 5893.8 6030.9 5932.9 5961.3 5964.9 5989.7 5992.7 5777.1 5916.5 5917.6 5919.5 5924.3 5148.3 5165.6 5196.3 5209.5 5211.0 20146.3 20159.9 20280.9 21180.3 21220.6 2158.9 2183.5 2228.0 2246.6 2635.4 12591.6 12738.4 12909.2 13120.6 13612.3 1769.5 1793.9 1800.5 1814.3 1831.8 59599.7 61669.1 62261.0 62767.0 63930.4 10058.8 10094.7 10126.7 10144.5 10151.3 13287.8 13357.3 13387.9 13389.0 13394.5 6973.8 7040.2 7115.9 7206.7 7247.6 6877.6 6887.4 6894.8 6968.2 6970.5 4275.3 4298.3 4308.7 4342.9 4348.3 1669.2 1717.1 1725.0 1790.0 1797.6 875.5 893.9 955.2 960.2 994.0 14539.9 15929.2 16737.7 16785.7 17097.1 861.3 893.0 905.5 906.6 943.9 8625.5 8817.3 8840.7 8884.5 8996.4 582381.0 589634.0 593514.0 608935.0 616021.0 82726.0 85827.1 85982.0 86211.6 86946.0 1105.8 1110.7 1117.1 1122.1 1123.6 14336.6 14463.3 14597.9 14709.1 14753.9 27377.0 33812.0 34225.3 36583.6 37257.6 44805.3 45533.3 45972.0 47861.0 48351.0 9352.8 9564.1 9594.0 9598.2 9620.8 11258.9 12389.6 14044.3 17574.6 17927.6 11693.1 13535.1 13626.7 13740.6 13820.3 13305.5 13976.3 14032.5 14044.4 14397.9 13983.7 14044.6 14134.9 14256.5 14309.1 9270.1 9343.4 9447.4 9452.7 9549.8 12796.7 13461.1 14454.9 14543.9 14762.9 11:10:09 INFO - PROCESS | 14704 | 11:10:09 INFO - PROCESS | 14704 | [#3] mootools.html Cycles:180 Average:5063.69 Median:6108.59 stddev:2562.57 (42.0%) stddev-sans-first:2554.46 11:10:09 INFO - PROCESS | 14704 | Values: 1338.7 1424.4 1426.1 1560.9 1755.1 6444.7 7028.5 7098.6 7115.5 7126.1 7065.3 7202.2 7220.1 7230.7 7235.7 1908.9 1938.8 2129.0 2158.7 2195.4 2241.7 2249.6 2252.5 2273.7 2274.8 2155.1 2229.1 2229.6 2230.1 2231.6 2168.2 2194.5 2210.8 2219.2 2222.7 2208.9 2235.6 2236.5 2238.3 2239.5 7192.4 7280.7 7297.0 7297.7 7299.0 4419.7 4520.1 4524.2 4574.3 4579.7 2769.7 2826.4 2838.9 2855.0 2919.7 894.3 917.2 920.6 923.3 1731.3 9500.5 9630.0 9647.9 9660.7 9665.8 3865.1 3930.8 3953.6 3953.8 3996.6 8188.5 8191.9 8192.2 8199.3 8229.5 4410.9 4416.9 4427.5 4433.7 4469.5 4038.3 4058.1 4063.1 4065.7 4070.2 3098.4 3127.0 3233.7 3448.6 3506.1 1128.5 1141.3 1149.1 1151.2 1152.7 1013.9 1023.4 1069.1 1087.2 1317.0 6675.8 6717.4 6739.4 6742.5 6750.1 1016.3 1024.5 1039.6 1092.2 1092.3 5496.7 5544.9 5563.8 5565.1 5566.3 8500.6 8656.9 8839.4 8866.9 8933.6 8719.7 8743.7 8797.2 8820.5 8837.7 6610.2 6774.9 6790.7 6992.8 7040.0 6672.7 6703.3 6737.3 6738.2 6740.8 7504.1 7852.8 7858.2 7859.3 7861.3 7801.6 7963.6 7965.2 7966.5 8071.8 6289.3 6351.3 6355.6 6357.7 6466.0 6265.2 6366.3 6730.2 6826.8 6843.9 6342.3 6372.6 6400.6 6437.8 6570.9 6300.6 6393.1 6440.2 6472.2 6518.2 6362.4 6395.4 6396.8 6400.8 6402.0 5816.4 5841.8 5858.1 5929.7 5951.9 5863.1 5899.6 5905.9 5925.4 5931.5 11:10:09 INFO - PROCESS | 14704 | 11:10:09 INFO - PROCESS | 14704 | [#4] prototype.html Cycles:180 Average:5288.77 Median:6046.55 stddev:1641.46 (27.1%) stddev-sans-first:1603.02 11:10:09 INFO - PROCESS | 14704 | Values: 313.4 313.7 313.8 317.2 318.4 5876.1 5929.6 6047.3 6052.4 6071.3 5886.4 5933.3 5938.1 5948.6 5953.6 4541.5 4551.6 4552.7 4555.5 4561.6 4333.6 4506.1 4552.8 4558.1 4560.5 4423.0 4430.8 4436.4 4437.3 4443.9 4431.2 4433.4 4442.5 4447.0 4450.2 3718.0 3805.7 3820.7 3880.8 3893.4 5670.7 5671.8 5672.4 5674.0 5677.3 4960.6 5120.2 5207.8 5215.4 5216.3 6136.2 6256.5 6276.9 6283.6 6307.5 4183.7 4185.3 4186.7 4190.3 4194.5 6524.0 6604.1 6616.6 6617.9 6623.0 4236.4 4336.2 4337.9 4338.8 4346.3 4341.3 4393.1 4396.1 4396.5 4396.9 5121.7 5122.9 5139.8 5144.5 5147.1 6215.4 6380.1 6384.8 6390.7 6394.4 1554.2 1587.5 1587.9 1590.7 1591.1 1020.1 1026.8 1029.4 1037.1 1045.7 6057.7 6117.0 6119.9 6120.1 6121.9 6569.1 6572.1 6574.4 6581.2 6584.5 6026.5 6029.9 6039.2 6045.8 6047.7 3453.6 3544.4 3547.7 3549.8 3552.2 6820.7 6839.1 6860.6 6862.5 6864.1 6740.2 6741.5 6747.4 6752.1 6752.3 6704.3 6832.5 6862.8 6868.3 6887.5 6582.5 6598.9 6625.0 6631.1 6632.5 6420.1 6555.6 6563.9 6565.6 6569.2 6848.0 6850.7 6858.5 6859.0 6862.7 4467.3 4489.5 4489.7 4490.5 4494.1 6636.4 6641.4 6645.4 6648.6 6655.6 6267.5 6449.9 6450.7 6461.7 6466.6 6421.2 6421.8 6422.1 6426.2 6440.5 6162.4 6315.8 6324.7 6326.5 6330.2 6447.8 6455.7 6458.3 6464.9 6475.9 6315.1 6317.1 6325.9 6331.0 6341.7 11:10:09 INFO - PROCESS | 14704 | 11:10:09 INFO - PROCESS | 14704 | [#5] yui.html Cycles:180 Average:13669.02 Median:47779.26 stddev:15832.44 (33.1%) stddev-sans-first:15847.03 11:10:09 INFO - PROCESS | 14704 | Values: 727.1 784.7 797.9 835.9 843.6 13197.9 13600.2 13609.0 13632.6 13638.5 14132.6 14137.3 14270.2 14284.2 14287.0 690.7 697.3 815.7 819.8 828.8 819.4 826.9 832.4 832.6 832.9 854.0 855.5 858.9 859.3 860.4 720.5 727.2 859.8 870.9 872.9 637.0 637.8 639.9 640.0 640.6 13063.5 13160.3 13211.9 13219.2 13224.3 11295.0 11813.0 11948.4 12384.7 12648.3 10022.2 10214.6 10252.0 10291.9 10426.6 3559.5 3633.2 3673.8 3742.7 3767.0 46522.5 46890.0 47057.3 47365.0 47365.8 9382.5 9441.9 9753.8 9813.5 9968.2 18255.0 18455.6 18467.9 18515.2 18547.2 7106.9 7240.1 7259.8 7281.9 7367.7 3832.8 3925.0 3941.2 4033.5 4079.0 3073.4 3095.8 3100.9 3105.3 3124.7 521.9 545.6 548.4 548.9 565.5 553.2 572.2 584.4 598.5 613.6 7542.5 7691.5 7704.8 7799.4 7854.7 566.2 602.5 614.2 626.1 636.8 3379.5 3608.9 3713.1 3743.1 3752.6 52221.0 53136.7 57358.4 57835.7 57899.7 45005.0 45545.5 45824.1 48107.0 53163.5 47207.0 47886.5 47897.5 48036.8 48375.5 7968.6 8221.6 8364.6 8371.4 8659.7 35376.5 35931.6 36018.1 36630.6 36925.4 44817.6 47069.2 47351.8 47672.0 48190.8 9819.2 9882.8 10282.9 10441.3 10492.7 11500.4 11637.9 11643.2 12026.5 12041.8 11390.9 11438.3 11532.3 11637.4 11936.8 11375.2 11565.9 11593.2 11755.3 11957.5 10792.0 10888.3 10996.5 11045.8 11413.8 9365.0 9449.3 9609.8 9639.4 9770.3 8840.7 9573.5 9714.5 9763.3 9821.0 11:10:09 INFO - PROCESS | 14704 | -------- Summary: end -------- 11:10:09 INFO - PROCESS | 14704 | 11:10:09 INFO - TEST-INFO | 14704: exit 0 11:10:09 INFO - TEST-OK | dromaeo_css | took 1115714ms 11:10:09 INFO - TEST-START | kraken 11:10:09 INFO - operating with platform_type : linux_ 11:10:09 INFO - Initialising browser for kraken test... 11:10:09 INFO - TEST-INFO | started process 14896 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3kyF0g/profile http://localhost:41364/getInfo.html) 11:10:14 INFO - PROCESS | 14896 | __metrics Screen width/height:1600/1200 11:10:14 INFO - PROCESS | 14896 | colorDepth:24 11:10:14 INFO - PROCESS | 14896 | Browser inner width/height: 1024/697 11:10:14 INFO - PROCESS | 14896 | __metrics 11:10:15 INFO - PROCESS | 14896 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:10:15 INFO - PROCESS | 14896 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:10:16 INFO - TEST-INFO | 14896: exit 0 11:10:16 INFO - Browser initialized. 11:10:16 INFO - Running cycle 1/1 for kraken test... 11:10:16 INFO - TEST-INFO | started process 14977 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3kyF0g/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:10:28 INFO - PROCESS | 14977 | RSS: Main: 148795392 11:10:28 INFO - PROCESS | 14977 | 11:10:30 INFO - PROCESS | 14977 | Cycle 1(1): loaded http://localhost:41364/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41364/tests/kraken/driver.html?testName=audio-beat-detection) 11:10:31 INFO - PROCESS | 14977 | RSS: Main: 184467456 11:10:31 INFO - PROCESS | 14977 | 11:10:34 INFO - PROCESS | 14977 | Cycle 1(1): loaded http://localhost:41364/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41364/tests/kraken/driver.html?testName=audio-dft) 11:10:34 INFO - PROCESS | 14977 | RSS: Main: 174628864 11:10:34 INFO - PROCESS | 14977 | 11:10:37 INFO - PROCESS | 14977 | Cycle 1(1): loaded http://localhost:41364/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41364/tests/kraken/driver.html?testName=audio-fft) 11:10:37 INFO - PROCESS | 14977 | RSS: Main: 159100928 11:10:37 INFO - PROCESS | 14977 | 11:10:39 INFO - PROCESS | 14977 | Cycle 1(1): loaded http://localhost:41364/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41364/tests/kraken/driver.html?testName=audio-oscillator) 11:10:40 INFO - PROCESS | 14977 | RSS: Main: 163139584 11:10:40 INFO - PROCESS | 14977 | 11:10:42 INFO - PROCESS | 14977 | Cycle 1(1): loaded http://localhost:41364/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41364/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:10:43 INFO - PROCESS | 14977 | RSS: Main: 165441536 11:10:43 INFO - PROCESS | 14977 | 11:10:46 INFO - PROCESS | 14977 | Cycle 1(1): loaded http://localhost:41364/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41364/tests/kraken/driver.html?testName=imaging-darkroom) 11:10:46 INFO - PROCESS | 14977 | RSS: Main: 164724736 11:10:46 INFO - PROCESS | 14977 | 11:10:50 INFO - PROCESS | 14977 | Cycle 1(1): loaded http://localhost:41364/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41364/tests/kraken/driver.html?testName=imaging-desaturate) 11:10:50 INFO - PROCESS | 14977 | RSS: Main: 164794368 11:10:50 INFO - PROCESS | 14977 | 11:10:53 INFO - PROCESS | 14977 | Cycle 1(1): loaded http://localhost:41364/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41364/tests/kraken/driver.html?testName=json-parse-financial) 11:10:54 INFO - PROCESS | 14977 | RSS: Main: 165773312 11:10:54 INFO - PROCESS | 14977 | 11:10:55 INFO - PROCESS | 14977 | Cycle 1(1): loaded http://localhost:41364/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41364/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:10:56 INFO - PROCESS | 14977 | RSS: Main: 175665152 11:10:56 INFO - PROCESS | 14977 | 11:10:58 INFO - PROCESS | 14977 | Cycle 1(1): loaded http://localhost:41364/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41364/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:10:58 INFO - PROCESS | 14977 | RSS: Main: 173215744 11:10:58 INFO - PROCESS | 14977 | 11:11:00 INFO - PROCESS | 14977 | Cycle 1(1): loaded http://localhost:41364/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41364/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:11:01 INFO - PROCESS | 14977 | RSS: Main: 180912128 11:11:01 INFO - PROCESS | 14977 | 11:11:03 INFO - PROCESS | 14977 | Cycle 1(1): loaded http://localhost:41364/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41364/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:11:04 INFO - PROCESS | 14977 | RSS: Main: 190214144 11:11:04 INFO - PROCESS | 14977 | 11:11:06 INFO - PROCESS | 14977 | Cycle 1(1): loaded http://localhost:41364/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41364/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:11:07 INFO - PROCESS | 14977 | RSS: Main: 187662336 11:11:07 INFO - PROCESS | 14977 | 11:11:09 INFO - PROCESS | 14977 | Cycle 1(1): loaded http://localhost:41364/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41364/tests/kraken/driver.html?testName=ai-astar) 11:11:09 INFO - PROCESS | 14977 | RSS: Main: 245731328 11:11:09 INFO - PROCESS | 14977 | 11:11:09 INFO - PROCESS | 14977 | __start_tp_report 11:11:09 INFO - PROCESS | 14977 | _x_x_mozilla_page_load 11:11:09 INFO - PROCESS | 14977 | _x_x_mozilla_page_load_details 11:11:09 INFO - PROCESS | 14977 | |i|pagename|runs| 11:11:09 INFO - PROCESS | 14977 | |0;ai-astar;108;109;103;110;110;109;98;112;110;101 11:11:09 INFO - PROCESS | 14977 | |1;audio-beat-detection;150;124;159;165;125;153;150;130;164;123 11:11:09 INFO - PROCESS | 14977 | |2;audio-dft;162;161;162;160;161;162;161;160;161;162 11:11:09 INFO - PROCESS | 14977 | |3;audio-fft;72;72;80;92;75;71;72;113;88;71 11:11:09 INFO - PROCESS | 14977 | |4;audio-oscillator;97;96;140;96;96;96;141;96;96;139 11:11:09 INFO - PROCESS | 14977 | |5;imaging-gaussian-blur;109;109;109;109;108;109;109;109;109;109 11:11:09 INFO - PROCESS | 14977 | |6;imaging-darkroom;145;152;144;145;145;145;146;145;146;145 11:11:09 INFO - PROCESS | 14977 | |7;imaging-desaturate;96;96;96;96;96;96;96;95;96;96 11:11:09 INFO - PROCESS | 14977 | |8;json-parse-financial;57;57;58;58;58;58;57;65;55;56 11:11:09 INFO - PROCESS | 14977 | |9;json-stringify-tinderbox;68;69;69;68;68;69;68;68;68;68 11:11:09 INFO - PROCESS | 14977 | |10;stanford-crypto-aes;85;87;87;87;85;85;85;86;87;87 11:11:09 INFO - PROCESS | 14977 | |11;stanford-crypto-ccm;129;120;117;114;116;124;128;117;121;114 11:11:09 INFO - PROCESS | 14977 | |12;stanford-crypto-pbkdf2;150;148;164;148;148;139;149;148;150;138 11:11:09 INFO - PROCESS | 14977 | |13;stanford-crypto-sha256-iterative;67;67;68;69;68;66;70;66;66;68 11:11:09 INFO - PROCESS | 14977 | __end_tp_report 11:11:09 INFO - PROCESS | 14977 | __start_cc_report 11:11:09 INFO - PROCESS | 14977 | _x_x_mozilla_cycle_collect,912 11:11:09 INFO - PROCESS | 14977 | __end_cc_report 11:11:09 INFO - PROCESS | 14977 | __startTimestamp1451329869424__endTimestamp 11:11:09 INFO - PROCESS | 14977 | 11:11:09 INFO - PROCESS | 14977 | ------- Summary: start ------- 11:11:09 INFO - PROCESS | 14977 | Number of tests: 14 11:11:09 INFO - PROCESS | 14977 | 11:11:09 INFO - PROCESS | 14977 | [#0] ai-astar Cycles:10 Average:107.00 Median:110.00 stddev:4.64 (4.2%) stddev-sans-first:4.91 11:11:09 INFO - PROCESS | 14977 | Values: 108.0 109.0 103.0 110.0 110.0 109.0 98.0 112.0 110.0 101.0 11:11:09 INFO - PROCESS | 14977 | 11:11:09 INFO - PROCESS | 14977 | [#1] audio-beat-detection Cycles:10 Average:144.30 Median:151.50 stddev:17.05 (11.3%) stddev-sans-first:17.96 11:11:09 INFO - PROCESS | 14977 | Values: 150.0 124.0 159.0 165.0 125.0 153.0 150.0 130.0 164.0 123.0 11:11:09 INFO - PROCESS | 14977 | 11:11:09 INFO - PROCESS | 14977 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.50 stddev:0.79 (0.5%) stddev-sans-first:0.78 11:11:09 INFO - PROCESS | 14977 | Values: 162.0 161.0 162.0 160.0 161.0 162.0 161.0 160.0 161.0 162.0 11:11:09 INFO - PROCESS | 14977 | 11:11:09 INFO - PROCESS | 14977 | [#3] audio-fft Cycles:10 Average:80.60 Median:73.50 stddev:13.63 (18.5%) stddev-sans-first:14.10 11:11:09 INFO - PROCESS | 14977 | Values: 72.0 72.0 80.0 92.0 75.0 71.0 72.0 113.0 88.0 71.0 11:11:09 INFO - PROCESS | 14977 | 11:11:09 INFO - PROCESS | 14977 | [#4] audio-oscillator Cycles:10 Average:109.30 Median:96.00 stddev:21.19 (22.1%) stddev-sans-first:22.01 11:11:09 INFO - PROCESS | 14977 | Values: 97.0 96.0 140.0 96.0 96.0 96.0 141.0 96.0 96.0 139.0 11:11:09 INFO - PROCESS | 14977 | 11:11:09 INFO - PROCESS | 14977 | [#5] imaging-gaussian-blur Cycles:10 Average:108.90 Median:109.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 11:11:09 INFO - PROCESS | 14977 | Values: 109.0 109.0 109.0 109.0 108.0 109.0 109.0 109.0 109.0 109.0 11:11:09 INFO - PROCESS | 14977 | 11:11:09 INFO - PROCESS | 14977 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:145.00 stddev:2.25 (1.6%) stddev-sans-first:2.37 11:11:09 INFO - PROCESS | 14977 | Values: 145.0 152.0 144.0 145.0 145.0 145.0 146.0 145.0 146.0 145.0 11:11:09 INFO - PROCESS | 14977 | 11:11:09 INFO - PROCESS | 14977 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 11:11:09 INFO - PROCESS | 14977 | Values: 96.0 96.0 96.0 96.0 96.0 96.0 96.0 95.0 96.0 96.0 11:11:09 INFO - PROCESS | 14977 | 11:11:09 INFO - PROCESS | 14977 | [#8] json-parse-financial Cycles:10 Average:57.90 Median:58.00 stddev:2.69 (4.6%) stddev-sans-first:2.83 11:11:09 INFO - PROCESS | 14977 | Values: 57.0 57.0 58.0 58.0 58.0 58.0 57.0 65.0 55.0 56.0 11:11:09 INFO - PROCESS | 14977 | 11:11:09 INFO - PROCESS | 14977 | [#9] json-stringify-tinderbox Cycles:10 Average:68.30 Median:68.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 11:11:09 INFO - PROCESS | 14977 | Values: 68.0 69.0 69.0 68.0 68.0 69.0 68.0 68.0 68.0 68.0 11:11:09 INFO - PROCESS | 14977 | 11:11:09 INFO - PROCESS | 14977 | [#10] stanford-crypto-aes Cycles:10 Average:86.10 Median:87.00 stddev:0.99 (1.1%) stddev-sans-first:0.97 11:11:09 INFO - PROCESS | 14977 | Values: 85.0 87.0 87.0 87.0 85.0 85.0 85.0 86.0 87.0 87.0 11:11:09 INFO - PROCESS | 14977 | 11:11:09 INFO - PROCESS | 14977 | [#11] stanford-crypto-ccm Cycles:10 Average:120.00 Median:120.50 stddev:5.46 (4.5%) stddev-sans-first:4.72 11:11:09 INFO - PROCESS | 14977 | Values: 129.0 120.0 117.0 114.0 116.0 124.0 128.0 117.0 121.0 114.0 11:11:09 INFO - PROCESS | 14977 | 11:11:09 INFO - PROCESS | 14977 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.20 Median:148.50 stddev:7.04 (4.7%) stddev-sans-first:7.43 11:11:09 INFO - PROCESS | 14977 | Values: 150.0 148.0 164.0 148.0 148.0 139.0 149.0 148.0 150.0 138.0 11:11:09 INFO - PROCESS | 14977 | 11:11:09 INFO - PROCESS | 14977 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:68.00 stddev:1.35 (2.0%) stddev-sans-first:1.42 11:11:09 INFO - PROCESS | 14977 | Values: 67.0 67.0 68.0 69.0 68.0 66.0 70.0 66.0 66.0 68.0 11:11:09 INFO - PROCESS | 14977 | -------- Summary: end -------- 11:11:09 INFO - PROCESS | 14977 | 11:11:10 INFO - TEST-INFO | 14977: exit 0 11:11:10 INFO - TEST-OK | kraken | took 60442ms 11:11:10 INFO - TEST-START | v8_7 11:11:10 INFO - operating with platform_type : linux_ 11:11:10 INFO - Initialising browser for v8_7 test... 11:11:10 INFO - TEST-INFO | started process 15225 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpAocc4l/profile http://localhost:41364/getInfo.html) 11:11:15 INFO - PROCESS | 15225 | __metrics Screen width/height:1600/1200 11:11:15 INFO - PROCESS | 15225 | colorDepth:24 11:11:15 INFO - PROCESS | 15225 | Browser inner width/height: 1024/697 11:11:15 INFO - PROCESS | 15225 | __metrics 11:11:15 INFO - PROCESS | 15225 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:11:15 INFO - PROCESS | 15225 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:11:16 INFO - TEST-INFO | 15225: exit 0 11:11:16 INFO - Browser initialized. 11:11:16 INFO - Running cycle 1/1 for v8_7 test... 11:11:16 INFO - TEST-INFO | started process 15309 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpAocc4l/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:11:28 INFO - PROCESS | 15309 | RSS: Main: 148348928 11:11:28 INFO - PROCESS | 15309 | 11:11:50 INFO - PROCESS | 15309 | Cycle 1(1): loaded http://localhost:41364/tests/v8_7/run.html (next: http://localhost:41364/tests/v8_7/run.html) 11:11:50 INFO - PROCESS | 15309 | RSS: Main: 549859328 11:11:50 INFO - PROCESS | 15309 | 11:11:50 INFO - PROCESS | 15309 | __start_tp_report 11:11:50 INFO - PROCESS | 15309 | _x_x_mozilla_page_load 11:11:50 INFO - PROCESS | 15309 | _x_x_mozilla_page_load_details 11:11:50 INFO - PROCESS | 15309 | |i|pagename|runs| 11:11:50 INFO - PROCESS | 15309 | |0;Richards;167.36401673640168 11:11:50 INFO - PROCESS | 15309 | |1;DeltaBlue;192.86403085824494 11:11:50 INFO - PROCESS | 15309 | |2;Encrypt;281.8489289740699 11:11:50 INFO - PROCESS | 15309 | |3;Decrypt;5164.948453608247 11:11:50 INFO - PROCESS | 15309 | |4;RayTrace;1116.0714285714287 11:11:50 INFO - PROCESS | 15309 | |5;Earley;796.8127490039841 11:11:50 INFO - PROCESS | 15309 | |6;Boyer;12268.292682926829 11:11:50 INFO - PROCESS | 15309 | |7;RegExp;26394.736842105263 11:11:50 INFO - PROCESS | 15309 | |8;Splay;613.4969325153374 11:11:50 INFO - PROCESS | 15309 | |9;NavierStokes;4830.917874396136 11:11:50 INFO - PROCESS | 15309 | __end_tp_report 11:11:50 INFO - PROCESS | 15309 | __startTimestamp1451329910267__endTimestamp 11:11:50 INFO - PROCESS | 15309 | 11:11:50 INFO - PROCESS | 15309 | ------- Summary: start ------- 11:11:50 INFO - PROCESS | 15309 | Number of tests: 10 11:11:50 INFO - PROCESS | 15309 | 11:11:50 INFO - PROCESS | 15309 | [#0] Richards Cycles:1 Average:167.36 Median:167.36 stddev:0.00 (0.0%) 11:11:50 INFO - PROCESS | 15309 | Values: 167.4 11:11:50 INFO - PROCESS | 15309 | 11:11:50 INFO - PROCESS | 15309 | [#1] DeltaBlue Cycles:1 Average:192.86 Median:192.86 stddev:0.00 (0.0%) 11:11:50 INFO - PROCESS | 15309 | Values: 192.9 11:11:50 INFO - PROCESS | 15309 | 11:11:50 INFO - PROCESS | 15309 | [#2] Encrypt Cycles:1 Average:281.85 Median:281.85 stddev:0.00 (0.0%) 11:11:50 INFO - PROCESS | 15309 | Values: 281.8 11:11:50 INFO - PROCESS | 15309 | 11:11:50 INFO - PROCESS | 15309 | [#3] Decrypt Cycles:1 Average:5164.95 Median:5164.95 stddev:0.00 (0.0%) 11:11:50 INFO - PROCESS | 15309 | Values: 5164.9 11:11:50 INFO - PROCESS | 15309 | 11:11:50 INFO - PROCESS | 15309 | [#4] RayTrace Cycles:1 Average:1116.07 Median:1116.07 stddev:0.00 (0.0%) 11:11:50 INFO - PROCESS | 15309 | Values: 1116.1 11:11:50 INFO - PROCESS | 15309 | 11:11:50 INFO - PROCESS | 15309 | [#5] Earley Cycles:1 Average:796.81 Median:796.81 stddev:0.00 (0.0%) 11:11:50 INFO - PROCESS | 15309 | Values: 796.8 11:11:50 INFO - PROCESS | 15309 | 11:11:50 INFO - PROCESS | 15309 | [#6] Boyer Cycles:1 Average:12268.29 Median:12268.29 stddev:0.00 (0.0%) 11:11:50 INFO - PROCESS | 15309 | Values: 12268.3 11:11:50 INFO - PROCESS | 15309 | 11:11:50 INFO - PROCESS | 15309 | [#7] RegExp Cycles:1 Average:26394.74 Median:26394.74 stddev:0.00 (0.0%) 11:11:50 INFO - PROCESS | 15309 | Values: 26394.7 11:11:50 INFO - PROCESS | 15309 | 11:11:50 INFO - PROCESS | 15309 | [#8] Splay Cycles:1 Average:613.50 Median:613.50 stddev:0.00 (0.0%) 11:11:50 INFO - PROCESS | 15309 | Values: 613.5 11:11:50 INFO - PROCESS | 15309 | 11:11:50 INFO - PROCESS | 15309 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 11:11:50 INFO - PROCESS | 15309 | Values: 4830.9 11:11:50 INFO - PROCESS | 15309 | -------- Summary: end -------- 11:11:50 INFO - PROCESS | 15309 | 11:11:51 INFO - TEST-INFO | 15309: exit 0 11:11:51 INFO - TEST-OK | v8_7 | took 40739ms 11:11:51 INFO - SUITE-END | took 1216s 11:11:51 INFO - Completed test suite (00:20:17) 11:11:51 INFO - Working with test: dromaeo_css 11:11:51 INFO - Generating results file: dromaeo_css 11:11:51 INFO - Working with test: kraken 11:11:51 INFO - Generating results file: kraken 11:11:51 INFO - javascript benchmark 11:11:51 INFO - Working with test: v8_7 11:11:51 INFO - Generating results file: v8_7 11:11:51 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:11:51 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 11:11:51 INFO - process_Request line: dromaeo_css 6849.40 graph.html#tests=[[72,64,35]] 11:11:51 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:11:51 INFO - process_Request line: kraken 1501.00 graph.html#tests=[[232,64,35]] 11:11:51 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:11:51 INFO - process_Request line: v8_7 20852.75 graph.html#tests=[[230,64,35]] 11:11:51 INFO - RETURN: dromaeo_css: 6849.40 11:11:51 INFO - RETURN: kraken: 1501.00 11:11:51 INFO - RETURN: v8_7: 20852.75 11:11:51 INFO - javascript benchmark 11:11:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3137.372525494901, 3193.936121277576, 3241.7082462578364, 3253.024092772168, 3273.3944220319236, 5180.222966555009, 5283.735813209339, 5293.0, 5303.204519322094, 5339.893202135955, 5195.532402083812, 5291.947080529194, 5321.627486075976, 5373.167159090338, 5379.193121031847, 4779.880502987418, 4808.687435316702, 4873.415190177184, 4911.214205727084, 4943.357363542735, 4869.659123861331, 4890.119778439879, 4902.901941961159, 4967.0810899983435, 4973.254011898208, 4730.314104454852, 4753.904921901577, 4821.90356192876, 4823.927641085386, 4832.395950506187, 4820.831270905502, 4820.855374338776, 4823.276508523714, 4828.275758636198, 4853.757312134379, 4704.623630109583, 4787.497312782178, 4794.137055330039, 4815.975920120412, 4827.879303017417, 5016.247562865563, 5038.7984480620735, 5119.744012799345, 5128.948710512885, 5164.612654050924, 5728.0, 5733.312002559678, 5736.4550367715, 5746.310442746855, 5747.39652336507, 5600.831975040755, 5715.942840571583, 5757.136429535562, 5770.105633626795, 5771.653700777967, 5282.867928301785, 5296.761645725952, 5340.626156169031, 5347.41178470368, 5370.006548788487, 5789.681567513827, 5794.304683438015, 5797.159411885253, 5808.128780682931, 5808.244928159397, 5421.972890135524, 5514.834554963358, 5590.664560126405, 5600.411956744565, 5601.747921343549, 5623.775048998076, 5711.857203569944, 5740.54075673945, 5750.884982300414, 5800.361960184377, 5660.066089095253, 5694.829155125353, 5699.572532060112, 5711.6001879868845, 5720.11338242573, 5578.0, 5673.517750991212, 5695.658260504383, 5696.088625819849, 5699.373068962411, 4303.505096913832, 4365.890852728708, 4370.409994650745, 4371.038371558252, 4408.58118478744, 3927.8036098194975, 3932.075962148893, 3949.7037722170376, 3975.602439756059, 4003.2193722223888, 5126.871828204325, 5213.400458947193, 5317.654352467077, 5322.654027488201, 5372.059889519319, 5651.943480565224, 5673.375928647845, 5782.219400380979, 5789.131630255495, 5801.6519008859605, 5307.124324486494, 5307.177387504943, 5308.442613525602, 5313.388960269618, 5318.97340513295, 4891.828785992473, 4923.729194894244, 4923.90152196954, 4935.777889994887, 4969.229769385751, 5715.399883012307, 5760.452756988163, 5801.3038435388025, 5809.564282678816, 5905.616134951214, 5683.943160568341, 5705.429457054262, 5711.485966263056, 5711.543076553949, 5746.655200687972, 5862.824115276549, 5866.266716660418, 5868.559858010752, 5869.618474799125, 5872.882542349214, 5420.783168673209, 5510.448955104618, 5573.749181286771, 5613.943860561505, 5696.316442026983, 5696.629719068247, 5723.885522289447, 5726.770929162787, 5734.598578099493, 5735.684537350486, 5582.916256256241, 5588.776448941997, 5589.161625756169, 5589.301337332833, 5595.300587426572, 5356.517913387814, 5518.696471694096, 5520.641158324696, 5522.420145884625, 5522.9447705524035, 5343.7595308212, 5347.0375332440535, 5347.144456886879, 5348.705821179872, 5351.759170837399, 5439.401665816836, 5445.700486473282, 5450.155225939986, 5543.1408131739645, 5577.414371490935, 5427.3215848019, 5478.534324582455, 5482.890342193214, 5483.588730845123, 5511.22842802016], "unit": "score", "name": "dojo.html", "value": 5234.9474858076765}, {"lowerIsBetter": false, "replicates": [551.8494281277166, 584.9354175400767, 590.7932223721698, 592.6088781404274, 597.6742675241993, 27513.174604761865, 35708.821455892714, 35797.0, 35797.46303805445, 35830.82084589577, 38325.61674383255, 38901.0, 38905.22189556207, 38911.0, 38974.415383769265, 7527.811804704899, 7562.395008399315, 7585.393168546503, 8443.197896199867, 8689.0, 10009.649662261822, 10108.0, 10170.084692377684, 10171.186305095574, 10176.135028522585, 10069.798604027916, 10114.2414318926, 10171.694849154537, 10178.796424071514, 10187.134093602053, 7608.885866712004, 7687.0391201099865, 7689.19263477338, 9998.45008524531, 10201.0, 9872.45701486418, 10005.19958403326, 10010.799784004352, 10017.0, 10019.098281154731, 36609.08477288089, 37019.4447083294, 37045.25909481795, 37061.70284040046, 37140.25719485595, 2997.67025627183, 3032.438998785232, 3092.273315770792, 3120.60992375953, 3148.071318960912, 30728.692713072807, 31167.53248701271, 31392.0, 31513.21216969594, 31730.0, 2965.066004208689, 2996.625421822272, 3004.5943797587483, 3025.4705426550267, 3122.2350524121507, 207620.0, 209501.0, 209886.0, 210947.452627368, 211413.0, 52355.0, 52861.12805335359, 53927.460725392244, 54764.178537321975, 59426.0, 54862.0, 55018.72490637521, 55269.17096243559, 55365.0, 55488.72255638696, 13117.0818042738, 13153.21080735159, 13194.47222111124, 13229.603111906657, 13238.53665121716, 10916.399598022184, 10964.56141754321, 10983.890161098287, 10993.230473866912, 10993.670189894316, 18715.532111697044, 18842.71735923962, 19413.51466213328, 19657.311994080137, 19777.30779422742, 7785.221477852169, 7935.563544005136, 8029.237222463857, 8033.3974951878845, 8082.636281367235, 916.225789208118, 1005.7234260578399, 1028.5165971993151, 1057.349729916096, 1060.2419270221674, 28863.134105976853, 28879.0, 29224.707752922623, 29336.559951600742, 30491.390172196432, 1002.7242508310273, 1006.8590397344377, 1007.652359935821, 1026.1329176845554, 1084.5336505302637, 13813.102148360324, 13821.170729756246, 14307.85692143086, 14572.0, 15757.763633545506, 381406.0, 387043.0, 387094.0, 387884.0, 388037.0, 54232.0, 54587.0, 54790.0, 54820.72589637026, 54900.45099549033, 1345.5156143788229, 1345.7039451320693, 1351.9188848668914, 1393.9024268301325, 1486.7695507196402, 25226.102685403646, 27483.0, 30457.390852183275, 31689.524657130623, 32033.839830800698, 47798.56604301876, 48428.51571484381, 48465.0, 48526.75736621294, 48527.0, 296217.0, 298238.0, 298288.0, 298621.0, 392600.0, 27791.58312625353, 30899.382012360078, 31020.379592408477, 31212.687873120976, 31496.527552086278, 36111.0, 37229.81385093057, 37372.81313593415, 37540.43689344607, 37610.2477950434, 32480.512792308607, 33738.0, 33925.0, 34194.0, 34590.30819383548, 32968.175795605304, 34002.829985849916, 34006.0, 34046.0, 34280.14299642529, 32936.67063329336, 33679.32641347208, 33908.321833562695, 33918.321633566695, 33931.321373572886, 27669.53812772786, 30515.237119071313, 35025.82487087548, 36983.63016369802, 37562.624373757004, 24442.26673199807, 24598.139065132633, 24668.0, 24781.752182477943, 24846.0], "unit": "score", "name": "ext.html", "value": 18059.132140635284}, {"lowerIsBetter": false, "replicates": [342.3375767889134, 342.92627085176684, 343.0737010072803, 344.767282084593, 354.75521889895987, 13990.090644108126, 14387.78418323726, 15835.366585336587, 16293.918530407345, 17295.394661186845, 16259.105749183791, 16342.509724708249, 16556.50330490087, 16870.325186992537, 16915.91542042288, 5229.764660590264, 5357.383900851393, 5357.866053348678, 5363.222332761748, 5368.62419630626, 3939.665128464084, 4050.0077481017192, 5302.946970530304, 5893.793717219876, 6030.939690603103, 5932.881342373172, 5961.314448838374, 5964.850878728023, 5989.670568118751, 5992.700364981733, 5777.133429985514, 5916.5266778657815, 5917.55618328627, 5919.467247947662, 5924.3483216846325, 5148.297692039266, 5165.63840531163, 5196.324477817897, 5209.53114219722, 5211.0359583477175, 20146.294879679288, 20159.89920050405, 20280.89859550693, 21180.258690945742, 21220.575588488296, 2158.881261530615, 2183.5087105401317, 2228.0308065991344, 2246.606843802328, 2635.4333818229175, 12591.622251332476, 12738.363081845871, 12909.160904541175, 13120.60638180856, 13612.31938403076, 1769.5222289981632, 1793.9372121975798, 1800.4778614201996, 1814.3468351393487, 1831.8259765322407, 59599.70200148971, 61669.074963876024, 62261.0, 62767.0, 63930.360696392905, 10058.798824023479, 10094.697159085239, 10126.696199114038, 10144.529043288681, 10151.289409741246, 13287.800682989762, 13357.265350405822, 13387.866121338662, 13389.0, 13394.464221431228, 6973.825654358681, 7040.225575186725, 7115.89326160108, 7206.7117315306805, 7247.637618119178, 6877.552959057645, 6887.380135787703, 6894.758683446055, 6968.163820341591, 6970.477214208955, 4275.3112520554205, 4298.312270036779, 4308.655307575386, 4342.891427714332, 4348.326009468537, 1669.2321532095373, 1717.0985232752905, 1724.9650209873976, 1789.973150402745, 1797.5595978985232, 875.4572165257454, 893.8748575199347, 955.1833182628891, 960.1742501448748, 993.9861341431699, 14539.927300363643, 15929.203539822962, 16737.665246694996, 16785.748213776802, 17097.145142742815, 861.2550144125287, 893.0, 905.456725964416, 906.5512571277128, 943.9292053096045, 8625.482471051631, 8817.338699597556, 8840.690575829814, 8884.466931984101, 8996.370254082152, 582381.0, 589634.0, 593514.0, 608935.0, 616021.0, 82726.0, 85827.14172858317, 85982.0, 86211.56894215489, 86946.0, 1105.8230683090828, 1110.7389763405592, 1117.1398023521842, 1122.141561705296, 1123.5786580032488, 14336.56990290293, 14463.27683615794, 14597.854021460074, 14709.117452952856, 14753.92623036878, 27377.0, 33812.0, 34225.315493689486, 36583.634163658025, 37257.62742372542, 44805.32792008057, 45533.31700024568, 45972.0, 47861.0, 48351.0, 9352.766180845534, 9564.13922746956, 9594.0, 9598.232141428529, 9620.807583848424, 11258.887411126112, 12389.62831115068, 14044.297785110908, 17574.64850702953, 17927.551811204823, 11693.064554835762, 13535.120217185851, 13626.727465450835, 13740.587782366545, 13820.308984550933, 13305.467781289028, 13976.301184940508, 14032.508862189774, 14044.438222470986, 14397.856021440071, 13983.650408739863, 14044.648883777578, 14134.858651413355, 14256.50102246458, 14309.068275782636, 9270.072992700676, 9343.392679475812, 9447.385919915183, 9452.669156579486, 9549.809003820024, 12796.744065118459, 13461.057725959088, 14454.927725361305, 14543.92728036353, 14762.926185369004], "unit": "score", "name": "jquery.html", "value": 8834.178986410478}, {"lowerIsBetter": false, "replicates": [1338.668025314812, 1424.3661570601084, 1426.0944300369265, 1560.890737648365, 1755.0698129991108, 6444.677766111693, 7028.543144695597, 7098.574085554864, 7115.466340024493, 7126.14486261648, 7065.328793764585, 7202.2077571467225, 7220.0613920190435, 7230.674619642115, 7235.67439465224, 1908.9045547722558, 1938.8158124978174, 2129.0, 2158.719366482359, 2195.3962660268394, 2241.652543855697, 2249.640057590786, 2252.549490101978, 2273.715785526809, 2274.7725227477285, 2155.1164022750677, 2229.1194977983687, 2229.565234779219, 2230.130249202812, 2231.631780756173, 2168.165256376291, 2194.5391467791783, 2210.767869373725, 2219.2010876084596, 2222.6666000100035, 2208.878511681873, 2235.552889422122, 2236.463248820288, 2238.2613737466595, 2239.496113374494, 7192.4246060315045, 7280.672369743322, 7297.0, 7297.744578939764, 7298.9635051824935, 4419.734815911055, 4520.050789334244, 4524.2082635538645, 4574.290984897346, 4579.748113853737, 2769.709180536055, 2826.4488424757183, 2838.886444542216, 2854.985725071382, 2919.722626350493, 894.3381897395881, 917.1974522292994, 920.6133423961952, 923.3259720404143, 1731.2901710298718, 9500.524973751284, 9630.036996300454, 9647.855282170773, 9660.71017869465, 9665.806683866354, 3865.1496670732395, 3930.7838068906485, 3953.604639536081, 3953.8418463261723, 3996.6403023728003, 8188.50868947865, 8191.918080819116, 8192.221738934792, 8199.262066414052, 8229.506229626242, 4410.867673969786, 4416.933745993812, 4427.535108813592, 4433.7118087324225, 4469.463664360298, 4038.293298672779, 4058.1072164123843, 4063.146739184745, 4065.6950728695465, 4070.2266569351727, 3098.3648352087766, 3126.9530957035663, 3233.6766323367947, 3448.5689288838894, 3506.1409954561295, 1128.537299707116, 1141.3380239461092, 1149.1383957988112, 1151.159653452984, 1152.7175841918784, 1013.9442330671884, 1023.4064242739194, 1069.053887309721, 1087.2389327470803, 1317.0122408193854, 6675.833104172338, 6717.361850624183, 6739.427148692416, 6742.528023038439, 6750.088738020305, 1016.2581315639625, 1024.4877561219391, 1039.5633833789827, 1092.2190633696787, 1092.3282181458505, 5496.725163741797, 5544.91682624761, 5563.777448902079, 5565.1374037024325, 5566.276384070045, 8500.617472213766, 8656.913430865736, 8839.425437346552, 8866.911330886738, 8933.59798809055, 8719.694810681596, 8743.737687869247, 8797.208251257418, 8820.470771753715, 8837.734867953972, 6610.206775187008, 6774.932250677529, 6790.7283708652085, 6992.825179370455, 7040.014397984286, 6672.6997285121315, 6703.262641109572, 6737.258901520927, 6738.225104113089, 6740.764073257413, 7504.061992250969, 7852.803679907819, 7858.214178582325, 7859.253370929752, 7861.292483676497, 7801.648925798239, 7963.562004089831, 7965.163657815846, 7966.482178658369, 8071.757847264592, 6289.276733175743, 6351.30135685065, 6355.586886852339, 6357.650329231937, 6466.030095485715, 6265.248170219421, 6366.267879193767, 6730.192376914802, 6826.795196144124, 6843.931560684329, 6342.334054924167, 6372.6495042773095, 6400.615963042046, 6437.839054023687, 6570.934290657032, 6300.621962682254, 6393.1369265148605, 6440.194975628046, 6472.223333200046, 6518.152640156749, 6362.395572420613, 6395.392437718409, 6396.776112836028, 6400.807975760735, 6401.967990160019, 5816.447437493432, 5841.773227622247, 5858.121281807763, 5929.673867937132, 5951.940480595139, 5863.061910094364, 5899.587028907935, 5905.940940590711, 5925.4370834770625, 5931.525477961839], "unit": "score", "name": "mootools.html", "value": 4209.225281737681}, {"lowerIsBetter": false, "replicates": [313.373253493014, 313.67691277983675, 313.8054406268114, 317.21331098874776, 318.4284209843331, 5876.0598304271325, 5929.614575052618, 6047.304559975604, 6052.42501962314, 6071.301800292957, 5886.440788125132, 5933.288005439343, 5938.0795976623585, 5948.553858460622, 5953.553483488734, 4541.523140070294, 4551.5676010778925, 4552.704074235181, 4555.544445555434, 4561.635069194473, 4333.566643335673, 4506.076254367863, 4552.772361381918, 4558.133954548625, 4560.543945605446, 4423.0, 4430.822767089313, 4436.423264975549, 4437.267850804614, 4443.866683999485, 4431.202383570956, 4433.401490798733, 4442.511323754385, 4447.0, 4450.198964186461, 3717.981410092932, 3805.714571407128, 3820.6943444524372, 3880.844766209348, 3893.396523538856, 5670.659760414347, 5671.801486947937, 5672.40439753824, 5673.971630141864, 5677.261955945701, 4960.553550180465, 5120.15517439622, 5207.817726379596, 5215.3741551013745, 5216.3218781558535, 6136.171616831715, 6256.530760192958, 6276.87446251077, 6283.591566548205, 6307.4954003679595, 4183.6653067754505, 4185.2885009548145, 4186.727862688946, 4190.329547272422, 4194.475690538683, 6523.967380163116, 6604.108445359863, 6616.569922955041, 6617.86764264712, 6623.0, 4236.368997935817, 4336.154449882242, 4337.891552711208, 4338.848140315137, 4346.282863327516, 4341.283688191476, 4393.055493069006, 4396.07682386696, 4396.538363471854, 4396.934045989313, 5121.743912804345, 5122.92315615266, 5139.8458046258675, 5144.511271429208, 5147.124988751922, 6215.409536094155, 6380.138681278061, 6384.776532821329, 6390.712417941204, 6394.360563943568, 1554.2306558253738, 1587.5237428771554, 1587.8809089318347, 1590.7295759720876, 1591.1407839766396, 1020.1023099672241, 1026.7689769801734, 1029.4286670897575, 1037.1288117980932, 1045.6810672744887, 6057.697115144313, 6117.0, 6119.908201376983, 6120.051392034242, 6121.908171377433, 6569.113169722122, 6572.07990881277, 6574.3754343337305, 6581.2102547694585, 6584.539082264291, 6026.487748541423, 6029.939700603026, 6039.245094363205, 6045.78839740607, 6047.697615119227, 3453.5855697316483, 3544.3974524330924, 3547.69844563215, 3549.751517393809, 3552.200754830194, 6820.727170913207, 6839.076724642209, 6860.588364698134, 6862.519623626398, 6864.141982252218, 6740.224874139439, 6741.52809303344, 6747.426468750113, 6752.054712340277, 6752.324767523307, 6704.2625311215725, 6832.521723479408, 6862.769599880059, 6868.278830722702, 6887.5178737488895, 6582.506312026713, 6598.934010660024, 6625.0, 6631.071649969104, 6632.469402447696, 6420.101185833893, 6555.6066636002, 6563.901541476786, 6565.606063636197, 6569.178852643419, 6847.965760171167, 6850.691718872563, 6858.5199036067, 6858.965705171442, 6862.725490980305, 4467.285234362486, 4489.461264648263, 4489.663275254304, 4490.506044335055, 4494.056248187917, 6636.435902948304, 6641.402273795382, 6645.368689974444, 6648.5678430901835, 6655.633940133339, 6267.467265282502, 6449.871002579828, 6450.741970321323, 6461.709223085067, 6466.579672321284, 6421.165248517663, 6421.8073457796345, 6422.068800024063, 6426.228852537725, 6440.484761218998, 6162.403556689769, 6315.778947736807, 6324.747010119728, 6326.493880489642, 6330.240371155491, 6447.807155676215, 6455.709493072729, 6458.257300410325, 6464.8707025858275, 6475.935240647534, 6315.052742088724, 6317.115603815378, 6325.905111423241, 6330.968345158245, 6341.714622841891], "unit": "score", "name": "prototype.html", "value": 4746.478191714138}, {"lowerIsBetter": false, "replicates": [727.0511981863667, 784.6743601405417, 797.9162187970263, 835.9456635318704, 843.6414523827372, 13197.868021319784, 13600.183988960656, 13609.047366684335, 13632.591022269324, 13638.522651707191, 14132.57602271931, 14137.293135343243, 14270.215138167398, 14284.21436820977, 14287.0, 690.7340673840582, 697.3340459860846, 815.7226542975387, 819.7704642700023, 828.8342331533687, 819.4141189049828, 826.9297109745679, 832.3507664022072, 832.5753865528594, 832.9250367466926, 853.9658413663446, 855.4567849415635, 858.8883445152153, 859.3383095016833, 860.3547339495378, 720.4560556779624, 727.1928159742681, 859.8452278589851, 870.8693695945595, 872.8734333521668, 637.0412529143656, 637.7895294552833, 639.9168108145958, 640.014377858098, 640.6028262477247, 13063.542776002794, 13160.341982900816, 13211.933940330333, 13219.20684758908, 13224.27266500342, 11295.0, 11813.0, 11948.402579870972, 12384.690382740413, 12648.320121555083, 10022.198224142052, 10214.642487512976, 10252.0, 10291.948540257326, 10426.635067772668, 3559.483874838134, 3633.182533929845, 3673.797941113238, 3742.700583953277, 3766.9811650941842, 46522.5347746525, 46890.0, 47057.294140587575, 47365.0, 47365.76317118427, 9382.483963381943, 9441.858372124423, 9753.804923901482, 9813.460259685644, 9968.152707019985, 18255.0, 18455.630887382176, 18467.907660461613, 18515.166817493246, 18547.165377557772, 7106.942660573225, 7240.094988126484, 7259.818504537428, 7281.927180728231, 7367.705291788268, 3832.80835958201, 3924.9803750981064, 3941.231459865299, 4033.4756481657782, 4078.9592104079175, 3073.354595534918, 3095.8297293648616, 3100.891468798581, 3105.2857842695853, 3124.703153200442, 521.8930119325529, 545.5826292885945, 548.4131978782664, 548.9286392768914, 565.5249590344131, 553.1923391847947, 572.1793886506169, 584.3513699793226, 598.470906833037, 613.555172499943, 7542.547447153188, 7691.5385076894445, 7704.768856934301, 7799.3760499159935, 7854.72508462201, 566.1705601294124, 602.4878852975024, 614.1708693264058, 626.0515319291277, 636.78667646339, 3379.543761592203, 3608.855645774192, 3713.1459764254373, 3743.1390780120723, 3752.6434988676033, 52221.0, 53136.73431632817, 57358.42641573615, 57835.710821445624, 57899.710501447225, 45005.0, 45545.54454455413, 45824.08351832945, 48107.0, 53163.46836531663, 47207.0, 47886.521134788905, 47897.52102479, 48036.7598162007, 48375.5162448378, 7968.601569921597, 8221.630026648696, 8364.574273460872, 8371.372147089114, 8659.653613855628, 35376.469352960245, 35931.56273749125, 36018.09954751152, 36630.63369366272, 36925.446118308784, 44817.551824481336, 47069.16705797708, 47351.76324118357, 47672.0, 48190.759046205945, 9819.16537094355, 9882.752931176778, 10282.948585257025, 10441.269111162146, 10492.685219443429, 11500.367479788358, 11637.941810291233, 11643.184977051525, 12026.518939242333, 12041.75916481648, 11390.943045284721, 11438.256513326607, 11532.308061516336, 11637.359945202756, 11936.820947685965, 11375.20373573875, 11565.884341156481, 11593.24643898144, 11755.294682319089, 11957.461914214055, 10792.0, 10888.29226100301, 10996.505157268102, 11045.834312485158, 11413.771724565628, 9364.953175234352, 9449.338546301693, 9609.759756006155, 9639.421634701941, 9770.267229957924, 8840.734777956672, 9573.473458959825, 9714.465704386326, 9763.316567840184, 9820.950895245478], "unit": "score", "name": "yui.html", "value": 6187.653693141788}], "name": "dromaeo_css", "value": 6849.401224668055}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 109.0, 103.0, 110.0, 110.0, 109.0, 98.0, 112.0, 110.0, 101.0], "unit": "score", "name": "ai-astar", "value": 107.0}, {"lowerIsBetter": true, "replicates": [150.0, 124.0, 159.0, 165.0, 125.0, 153.0, 150.0, 130.0, 164.0, 123.0], "unit": "score", "name": "audio-beat-detection", "value": 144.3}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 162.0, 160.0, 161.0, 162.0, 161.0, 160.0, 161.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.2}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 80.0, 92.0, 75.0, 71.0, 72.0, 113.0, 88.0, 71.0], "unit": "score", "name": "audio-fft", "value": 80.6}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 140.0, 96.0, 96.0, 96.0, 141.0, 96.0, 96.0, 139.0], "unit": "score", "name": "audio-oscillator", "value": 109.3}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 108.0, 109.0, 109.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 108.9}, {"lowerIsBetter": true, "replicates": [145.0, 152.0, 144.0, 145.0, 145.0, 145.0, 146.0, 145.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.8}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [57.0, 57.0, 58.0, 58.0, 58.0, 58.0, 57.0, 65.0, 55.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 57.9}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 69.0, 68.0, 68.0, 69.0, 68.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.3}, {"lowerIsBetter": true, "replicates": [85.0, 87.0, 87.0, 87.0, 85.0, 85.0, 85.0, 86.0, 87.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.1}, {"lowerIsBetter": true, "replicates": [129.0, 120.0, 117.0, 114.0, 116.0, 124.0, 128.0, 117.0, 121.0, 114.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.0}, {"lowerIsBetter": true, "replicates": [150.0, 148.0, 164.0, 148.0, 148.0, 139.0, 149.0, 148.0, 150.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.2}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 68.0, 69.0, 68.0, 66.0, 70.0, 66.0, 66.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.5}], "name": "kraken", "value": 1500.9999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.36401673640168], "unit": "score", "name": "Richards", "value": 210.92945000000006}, {"lowerIsBetter": false, "replicates": [192.86403085824494], "unit": "score", "name": "DeltaBlue", "value": 342.82183000000015}, {"lowerIsBetter": false, "replicates": [281.8489289740699], "unit": "score", "name": "Encrypt", "value": 944.410188}, {"lowerIsBetter": false, "replicates": [5164.948453608247], "unit": "score", "name": "Decrypt", "value": 51.53604191616765}, {"lowerIsBetter": false, "replicates": [1116.0714285714287], "unit": "score", "name": "RayTrace", "value": 663.0301440000001}, {"lowerIsBetter": false, "replicates": [796.8127490039841], "unit": "score", "name": "Earley", "value": 836.4110649999999}, {"lowerIsBetter": false, "replicates": [12268.292682926829], "unit": "score", "name": "Boyer", "value": 54.32402186878729}, {"lowerIsBetter": false, "replicates": [26394.736842105263], "unit": "score", "name": "RegExp", "value": 34.51388833499503}, {"lowerIsBetter": false, "replicates": [613.4969325153374], "unit": "score", "name": "Splay", "value": 132.83032999999998}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 20852.753892991746}]} 11:11:51 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "20852.75"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1501.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6849.40"}}} 11:11:51 INFO - Return code: 0 11:11:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 11:11:51 INFO - # TBPL SUCCESS # 11:11:51 INFO - Running post-action listener: _resource_record_post_action 11:11:51 INFO - Running post-run listener: _resource_record_post_run 11:11:52 INFO - Total resource usage - Wall time: 1235s; CPU: 13.0%; Read bytes: 4096; Write bytes: 550199296; Read time: 8; Write time: 1594848 11:11:52 INFO - install - Wall time: 17s; CPU: 18.0%; Read bytes: 0; Write bytes: 235274240; Read time: 0; Write time: 896080 11:11:52 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 4096; Write bytes: 314925056; Read time: 8; Write time: 698768 11:11:52 INFO - Running post-run listener: _upload_blobber_files 11:11:52 INFO - Blob upload gear active. 11:11:52 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 11:11:52 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 11:11:52 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'] 11:11:52 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 11:11:53 INFO - (blobuploader) - INFO - Open directory for files ... 11:11:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 11:11:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:11:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:11:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:11:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:11:53 INFO - (blobuploader) - INFO - Done attempting. 11:11:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:11:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:11:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:11:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:11:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:11:54 INFO - (blobuploader) - INFO - Done attempting. 11:11:54 INFO - (blobuploader) - INFO - Iteration through files over. 11:11:54 INFO - Return code: 0 11:11:54 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 11:11:54 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 11:11:54 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cc3ca14ba232da5ab17c96bcba0f893b5b60f0584f26dc7759e28667dec9bff2a0789758d6ea3d1023f24c5d329a8921a83aabcd98c299e972ffc810578d7e2b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d4c72d6307fec8123b0dc70673ff41450f523df06265beae274d78dd1c8979fb133a52b40334d344b49ba5c34242776bda2b6e849f4bc96e485b388f156c64b6"} 11:11:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 11:11:54 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 11:11:54 INFO - Contents: 11:11:54 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cc3ca14ba232da5ab17c96bcba0f893b5b60f0584f26dc7759e28667dec9bff2a0789758d6ea3d1023f24c5d329a8921a83aabcd98c299e972ffc810578d7e2b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d4c72d6307fec8123b0dc70673ff41450f523df06265beae274d78dd1c8979fb133a52b40334d344b49ba5c34242776bda2b6e849f4bc96e485b388f156c64b6"} 11:11:54 INFO - Copying logs to upload dir... 11:11:54 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1283.822250 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2015-12-28 11:11:54.241759) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-28 11:11:54.250835) ========= 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=ccb4611811c763f2fad71465000001de-1451326949.843446-1081295317 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/cc3ca14ba232da5ab17c96bcba0f893b5b60f0584f26dc7759e28667dec9bff2a0789758d6ea3d1023f24c5d329a8921a83aabcd98c299e972ffc810578d7e2b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d4c72d6307fec8123b0dc70673ff41450f523df06265beae274d78dd1c8979fb133a52b40334d344b49ba5c34242776bda2b6e849f4bc96e485b388f156c64b6"} build_url:https://queue.taskcluster.net/v1/task/7spQg9DMR0WB6z602ZU4Zg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011169 build_url: 'https://queue.taskcluster.net/v1/task/7spQg9DMR0WB6z602ZU4Zg/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/cc3ca14ba232da5ab17c96bcba0f893b5b60f0584f26dc7759e28667dec9bff2a0789758d6ea3d1023f24c5d329a8921a83aabcd98c299e972ffc810578d7e2b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d4c72d6307fec8123b0dc70673ff41450f523df06265beae274d78dd1c8979fb133a52b40334d344b49ba5c34242776bda2b6e849f4bc96e485b388f156c64b6"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-28 11:11:54.276798) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 11:11:54.282994) ========= 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=ccb4611811c763f2fad71465000001de-1451326949.843446-1081295317 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004669 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 11:11:54.358079) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-28 11:11:54.358431) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-28 11:11:54.358830) ========= ========= Total master_lag: 0.26 =========