builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-047 starttime: 1451934817.77 results: success (0) buildid: 20160104083143 builduid: c64757a1e5434d6d9a347b78b5d3c26a revision: 9d5029646b5297649513b648d9109f20fdab9845 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-04 11:13:37.771056) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-04 11:13:37.771543) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-04 11:13:37.771864) ========= 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=03627c79f6bb3d1578c4a402000001ba-1451934817.282862-850247339 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006199 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-04 11:13:37.794733) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-04 11:13:37.795056) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-04 11:13:37.820322) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 11:13:37.820710) ========= 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=03627c79f6bb3d1578c4a402000001ba-1451934817.282862-850247339 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004384 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 11:13:37.871439) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-04 11:13:37.871764) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-04 11:13:37.872159) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 11:13:37.872474) ========= 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=03627c79f6bb3d1578c4a402000001ba-1451934817.282862-850247339 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-04 11:13:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 80.6M=0s 2016-01-04 11:13:38 (80.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.166674 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 11:13:38.051779) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 11:13:38.052103) ========= 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=03627c79f6bb3d1578c4a402000001ba-1451934817.282862-850247339 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004403 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 11:13:38.102547) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 11:13:38.102916) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 9d5029646b5297649513b648d9109f20fdab9845 --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 9d5029646b5297649513b648d9109f20fdab9845 --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=03627c79f6bb3d1578c4a402000001ba-1451934817.282862-850247339 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-04 11:13:38,339 truncating revision to first 12 chars 2016-01-04 11:13:38,339 Setting DEBUG logging. 2016-01-04 11:13:38,339 attempt 1/10 2016-01-04 11:13:38,339 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/9d5029646b52?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-04 11:13:38,600 unpacking tar archive at: fx-team-9d5029646b52/testing/mozharness/ program finished with exit code 0 elapsedTime=0.553141 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 11:13:38.669148) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-04 11:13:38.669488) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-04 11:13:38.679217) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-04 11:13:38.679571) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-04 11:13:38.680048) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-01-04 11:13:38.680354) ========= /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=03627c79f6bb3d1578c4a402000001ba-1451934817.282862-850247339 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:13:38 INFO - MultiFileLogger online at 20160104 11:13:38 in /builds/slave/test-pgo 11:13:38 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 11:13:38 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 11:13:39 INFO - {'append_to_log': False, 11:13:39 INFO - 'base_work_dir': '/builds/slave/test-pgo', 11:13:39 INFO - 'blob_upload_branch': 'Fx-Team', 11:13:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 11:13:39 INFO - 'branch': 'Fx-Team', 11:13:39 INFO - 'buildbot_json_path': 'buildprops.json', 11:13:39 INFO - 'config_files': ('talos/linux_config.py',), 11:13:39 INFO - 'default_actions': ('clobber', 11:13:39 INFO - 'read-buildbot-config', 11:13:39 INFO - 'download-and-extract', 11:13:39 INFO - 'populate-webroot', 11:13:39 INFO - 'create-virtualenv', 11:13:39 INFO - 'install', 11:13:39 INFO - 'run-tests'), 11:13:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:13:39 INFO - 'download_minidump_stackwalk': True, 11:13:39 INFO - 'download_symbols': 'ondemand', 11:13:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:13:39 INFO - 'tooltool.py': '/tools/tooltool.py', 11:13:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:13:39 INFO - '/tools/misc-python/virtualenv.py')}, 11:13:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:13:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:13:39 INFO - 'installer_path': 'installer.exe', 11:13:39 INFO - 'log_level': 'info', 11:13:39 INFO - 'log_name': 'talos', 11:13:39 INFO - 'log_to_console': True, 11:13:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:13:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:13:39 INFO - 'opt_config_files': (), 11:13:39 INFO - 'pip_index': False, 11:13:39 INFO - 'sps_profile': False, 11:13:39 INFO - 'sps_profile_interval': 0, 11:13:39 INFO - 'suite': 'dromaeojs', 11:13:39 INFO - 'system_bits': '32', 11:13:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:13:39 INFO - 'title': 'talos-linux64-ix-047', 11:13:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:13:39 INFO - 'use_talos_json': True, 11:13:39 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 11:13:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:13:39 INFO - 'work_dir': 'build'} 11:13:39 INFO - ##### 11:13:39 INFO - ##### Running clobber step. 11:13:39 INFO - ##### 11:13:39 INFO - Running pre-action listener: _resource_record_pre_action 11:13:39 INFO - Running main action method: clobber 11:13:39 INFO - rmtree: /builds/slave/test-pgo/build 11:13:39 INFO - Running post-action listener: _resource_record_post_action 11:13:39 INFO - ##### 11:13:39 INFO - ##### Running read-buildbot-config step. 11:13:39 INFO - ##### 11:13:39 INFO - Running pre-action listener: _resource_record_pre_action 11:13:39 INFO - Running main action method: read_buildbot_config 11:13:39 INFO - Using buildbot properties: 11:13:39 INFO - { 11:13:39 INFO - "project": "", 11:13:39 INFO - "product": "firefox", 11:13:39 INFO - "script_repo_revision": "production", 11:13:39 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:13:39 INFO - "repository": "", 11:13:39 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 11:13:39 INFO - "buildid": "20160104083143", 11:13:39 INFO - "pgo_build": "True", 11:13:39 INFO - "basedir": "/builds/slave/test-pgo", 11:13:39 INFO - "buildnumber": 398, 11:13:39 INFO - "slavename": "talos-linux64-ix-047", 11:13:39 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:13:39 INFO - "platform": "ubuntu64_hw", 11:13:39 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 11:13:39 INFO - "branch": "fx-team", 11:13:39 INFO - "repo_path": "integration/fx-team", 11:13:39 INFO - "revision": "9d5029646b5297649513b648d9109f20fdab9845", 11:13:39 INFO - "stage_platform": "linux64-pgo", 11:13:39 INFO - "builduid": "c64757a1e5434d6d9a347b78b5d3c26a", 11:13:39 INFO - "slavebuilddir": "test" 11:13:39 INFO - } 11:13:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/DOZITRv2QXKgWGk0fmwpsQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 11:13:39 INFO - Running post-action listener: _resource_record_post_action 11:13:39 INFO - ##### 11:13:39 INFO - ##### Running download-and-extract step. 11:13:39 INFO - ##### 11:13:39 INFO - Running pre-action listener: _resource_record_pre_action 11:13:39 INFO - Running main action method: download_and_extract 11:13:39 INFO - mkdir: /builds/slave/test-pgo/build/tests 11:13:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:13:39 INFO - https://queue.taskcluster.net/v1/task/DOZITRv2QXKgWGk0fmwpsQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 11:13:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DOZITRv2QXKgWGk0fmwpsQ/artifacts/public/build/test_packages.json 11:13:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DOZITRv2QXKgWGk0fmwpsQ/artifacts/public/build/test_packages.json 11:13:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DOZITRv2QXKgWGk0fmwpsQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 11:13:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DOZITRv2QXKgWGk0fmwpsQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 11:13:39 INFO - Downloaded 1302 bytes. 11:13:39 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 11:13:39 INFO - Using the following test package requirements: 11:13:39 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 11:13:39 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:13:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:13:39 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:13:39 INFO - u'jsshell-linux-x86_64.zip'], 11:13:39 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:13:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:13:39 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 11:13:39 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:13:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:13:39 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:13:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:13:39 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:13:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:13:39 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 11:13:39 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:13:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:13:39 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:13:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:13:39 INFO - https://queue.taskcluster.net/v1/task/DOZITRv2QXKgWGk0fmwpsQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:13:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DOZITRv2QXKgWGk0fmwpsQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:13:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DOZITRv2QXKgWGk0fmwpsQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:13:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DOZITRv2QXKgWGk0fmwpsQ/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 11:13:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DOZITRv2QXKgWGk0fmwpsQ/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 11:13:41 INFO - Downloaded 23198177 bytes. 11:13:41 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 11:13:41 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:13:41 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 11:13:42 INFO - Return code: 0 11:13:42 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 11:13:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:13:42 INFO - https://queue.taskcluster.net/v1/task/DOZITRv2QXKgWGk0fmwpsQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:13:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DOZITRv2QXKgWGk0fmwpsQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:13:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DOZITRv2QXKgWGk0fmwpsQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:13:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DOZITRv2QXKgWGk0fmwpsQ/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 11:13:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DOZITRv2QXKgWGk0fmwpsQ/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 11:13:43 INFO - Downloaded 23198177 bytes. 11:13: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 11:13:43 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:13: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 11:13:44 INFO - Return code: 0 11:13: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')]} 11:13:44 INFO - https://queue.taskcluster.net/v1/task/DOZITRv2QXKgWGk0fmwpsQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:13:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DOZITRv2QXKgWGk0fmwpsQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 11:13:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DOZITRv2QXKgWGk0fmwpsQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 11:13:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DOZITRv2QXKgWGk0fmwpsQ/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 11:13:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DOZITRv2QXKgWGk0fmwpsQ/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 11:13:49 INFO - Downloaded 11132285 bytes. 11:13:49 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 11:13:49 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 11:13:49 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 11:13:49 INFO - Return code: 0 11:13: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')]} 11:13:49 INFO - https://queue.taskcluster.net/v1/task/DOZITRv2QXKgWGk0fmwpsQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:13:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DOZITRv2QXKgWGk0fmwpsQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:13:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DOZITRv2QXKgWGk0fmwpsQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:13:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DOZITRv2QXKgWGk0fmwpsQ/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 11:13:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DOZITRv2QXKgWGk0fmwpsQ/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 11:13:50 INFO - Downloaded 54985130 bytes. 11:13:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DOZITRv2QXKgWGk0fmwpsQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:13:50 INFO - mkdir: /builds/slave/test-pgo/properties 11:13:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 11:13:50 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 11:13:50 INFO - Contents: 11:13:50 INFO - build_url:https://queue.taskcluster.net/v1/task/DOZITRv2QXKgWGk0fmwpsQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:13:50 INFO - Running post-action listener: _resource_record_post_action 11:13:50 INFO - Running post-action listener: set_extra_try_arguments 11:13:50 INFO - ##### 11:13:50 INFO - ##### Running populate-webroot step. 11:13:50 INFO - ##### 11:13:50 INFO - Running pre-action listener: _resource_record_pre_action 11:13:50 INFO - Running main action method: populate_webroot 11:13:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:13:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:13:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:13:50 INFO - '--tppagecycles', 11:13:50 INFO - '7'], 11:13:50 INFO - 'tests': ['tsvgm']}}, 11:13:50 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:13:50 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:13:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:13:50 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:13:50 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:13:50 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:13:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:13:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:13:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:13:50 INFO - 'talos_options': ['--e10s'], 11:13:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:13:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:13:50 INFO - 'tests': ['damp', 'tps']}, 11:13:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:13:50 INFO - 'talos_options': ['--e10s'], 11:13:50 INFO - 'tests': ['damp', 'tps']}, 11:13:50 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:13:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:13:50 INFO - 'other': {'tests': ['a11yr', 11:13:50 INFO - 'ts_paint', 11:13:50 INFO - 'tpaint', 11:13:50 INFO - 'sessionrestore', 11:13:50 INFO - 'sessionrestore_no_auto_restore']}, 11:13:50 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:13:50 INFO - 'tests': ['a11yr', 11:13:50 INFO - 'ts_paint', 11:13:50 INFO - 'tpaint', 11:13:50 INFO - 'sessionrestore', 11:13:50 INFO - 'sessionrestore_no_auto_restore']}, 11:13:50 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:13:50 INFO - 'tests': ['a11yr', 11:13:50 INFO - 'ts_paint', 11:13:50 INFO - 'tpaint', 11:13:50 INFO - 'sessionrestore', 11:13:50 INFO - 'sessionrestore_no_auto_restore']}, 11:13:50 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:13:50 INFO - 'tests': ['a11yr', 11:13:50 INFO - 'ts_paint', 11:13:50 INFO - 'tpaint', 11:13:50 INFO - 'sessionrestore', 11:13:50 INFO - 'sessionrestore_no_auto_restore']}, 11:13:50 INFO - 'other_l64': {'tests': ['a11yr', 11:13:50 INFO - 'ts_paint', 11:13:50 INFO - 'tpaint', 11:13:50 INFO - 'sessionrestore', 11:13:50 INFO - 'sessionrestore_no_auto_restore']}, 11:13:50 INFO - 'other_nol64': {'tests': ['a11yr', 11:13:50 INFO - 'ts_paint', 11:13:50 INFO - 'tpaint', 11:13:50 INFO - 'sessionrestore', 11:13:50 INFO - 'sessionrestore_no_auto_restore']}, 11:13:50 INFO - 'svgr': {'tests': ['tsvgx', 11:13:50 INFO - 'tsvgr_opacity', 11:13:50 INFO - 'tart', 11:13:50 INFO - 'tscrollx', 11:13:50 INFO - 'cart']}, 11:13:50 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:13:50 INFO - 'tests': ['tsvgx', 11:13:50 INFO - 'tsvgr_opacity', 11:13:50 INFO - 'tart', 11:13:50 INFO - 'tscrollx', 11:13:50 INFO - 'cart']}, 11:13:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:13:50 INFO - 'tests': ['tp5o']}, 11:13:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:13:50 INFO - 'talos_options': ['--e10s'], 11:13:50 INFO - 'tests': ['tp5o']}, 11:13:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:13:50 INFO - 'talos_options': ['--xperf_path', 11:13:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:13:50 INFO - 'tests': ['tp5n']}, 11:13:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:13:50 INFO - 'talos_options': ['--e10s', 11:13:50 INFO - '--xperf_path', 11:13:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:13:50 INFO - 'tests': ['tp5n']}}, 11:13:50 INFO - 'talos.zip': {'path': '', 11:13:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:13:50 INFO - Running post-action listener: _resource_record_post_action 11:13:50 INFO - ##### 11:13:50 INFO - ##### Running create-virtualenv step. 11:13:50 INFO - ##### 11:13:50 INFO - Running pre-action listener: _resource_record_pre_action 11:13:50 INFO - Running main action method: create_virtualenv 11:13:50 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 11:13:50 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 11:13:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 11:13:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:13:50 INFO - Using real prefix '/usr' 11:13:50 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 11:13:51 INFO - Installing distribute.............................................................................................................................................................................................done. 11:13:53 INFO - Installing pip.................done. 11:13:53 INFO - Return code: 0 11:13:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 11:13:53 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')]} 11:13:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:53 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')]} 11:13:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:53 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 0x7ff0a9fe4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26be630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274f840>, '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 0x26bc6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26bcb60>, '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': '03627c79f6bb3d1578c4a402000001ba-1451934817.282862-850247339', '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 11:13:53 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 11:13:53 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 11:13:53 INFO - Using env: {'DISPLAY': ':0', 11:13:53 INFO - 'HOME': '/home/cltbld', 11:13:53 INFO - 'LANG': 'en_US.UTF-8', 11:13:53 INFO - 'LANGUAGE': 'en_US:en', 11:13:53 INFO - 'LOGNAME': 'cltbld', 11:13:53 INFO - 'MAIL': '/var/mail/cltbld', 11:13:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:53 INFO - 'MOZ_NO_REMOTE': '1', 11:13:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:53 INFO - 'NO_EM_RESTART': '1', 11:13:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:13:53 INFO - 'PWD': '/builds/slave/test-pgo', 11:13:53 INFO - 'SHELL': '/bin/bash', 11:13:53 INFO - 'SHLVL': '1', 11:13:53 INFO - 'TERM': 'linux', 11:13:53 INFO - 'TMOUT': '86400', 11:13:53 INFO - 'USER': 'cltbld', 11:13:53 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1451934817.282862-850247339', 11:13:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:53 INFO - '_': '/tools/buildbot/bin/python'} 11:13:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:53 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 11:13:53 INFO - Cleaning up... 11:13:53 INFO - Return code: 0 11:13:53 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 11:13:53 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')]} 11:13:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:53 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')]} 11:13:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:53 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 0x7ff0a9fe4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26be630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274f840>, '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 0x26bc6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26bcb60>, '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': '03627c79f6bb3d1578c4a402000001ba-1451934817.282862-850247339', '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 11:13:53 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 11:13:53 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 11:13:53 INFO - Using env: {'DISPLAY': ':0', 11:13:53 INFO - 'HOME': '/home/cltbld', 11:13:53 INFO - 'LANG': 'en_US.UTF-8', 11:13:53 INFO - 'LANGUAGE': 'en_US:en', 11:13:53 INFO - 'LOGNAME': 'cltbld', 11:13:53 INFO - 'MAIL': '/var/mail/cltbld', 11:13:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:53 INFO - 'MOZ_NO_REMOTE': '1', 11:13:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:53 INFO - 'NO_EM_RESTART': '1', 11:13:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:13:53 INFO - 'PWD': '/builds/slave/test-pgo', 11:13:53 INFO - 'SHELL': '/bin/bash', 11:13:53 INFO - 'SHLVL': '1', 11:13:53 INFO - 'TERM': 'linux', 11:13:53 INFO - 'TMOUT': '86400', 11:13:53 INFO - 'USER': 'cltbld', 11:13:53 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1451934817.282862-850247339', 11:13:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:53 INFO - '_': '/tools/buildbot/bin/python'} 11:13:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:53 INFO - Downloading/unpacking psutil>=0.7.1 11:13:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:13:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:13:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:55 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 11:13:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 11:13:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 11:13:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:13:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:13:55 INFO - Installing collected packages: psutil 11:13:55 INFO - Running setup.py install for psutil 11:13:55 INFO - building 'psutil._psutil_linux' extension 11:13:55 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 11:13:55 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 11:13:55 INFO - building 'psutil._psutil_posix' extension 11:13:55 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 11:13:55 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 11:13:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:13:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:13:55 INFO - Successfully installed psutil 11:13:55 INFO - Cleaning up... 11:13:56 INFO - Return code: 0 11:13:56 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 11:13:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:13:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:13:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:56 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff0a9fe4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26be630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274f840>, '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 0x26bc6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26bcb60>, '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': '03627c79f6bb3d1578c4a402000001ba-1451934817.282862-850247339', '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 11:13:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 11:13:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 11:13:56 INFO - Using env: {'DISPLAY': ':0', 11:13:56 INFO - 'HOME': '/home/cltbld', 11:13:56 INFO - 'LANG': 'en_US.UTF-8', 11:13:56 INFO - 'LANGUAGE': 'en_US:en', 11:13:56 INFO - 'LOGNAME': 'cltbld', 11:13:56 INFO - 'MAIL': '/var/mail/cltbld', 11:13:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:56 INFO - 'MOZ_NO_REMOTE': '1', 11:13:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:56 INFO - 'NO_EM_RESTART': '1', 11:13:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:13:56 INFO - 'PWD': '/builds/slave/test-pgo', 11:13:56 INFO - 'SHELL': '/bin/bash', 11:13:56 INFO - 'SHLVL': '1', 11:13:56 INFO - 'TERM': 'linux', 11:13:56 INFO - 'TMOUT': '86400', 11:13:56 INFO - 'USER': 'cltbld', 11:13:56 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1451934817.282862-850247339', 11:13:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:56 INFO - '_': '/tools/buildbot/bin/python'} 11:13:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:56 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:13:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:13:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:13:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:57 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:13:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 11:13:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:13:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:13:58 INFO - Installing collected packages: mozsystemmonitor 11:13:58 INFO - Running setup.py install for mozsystemmonitor 11:13:58 INFO - Successfully installed mozsystemmonitor 11:13:58 INFO - Cleaning up... 11:13:58 INFO - Return code: 0 11:13:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 11:13:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:13:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:13:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff0a9fe4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26be630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274f840>, '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 0x26bc6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26bcb60>, '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': '03627c79f6bb3d1578c4a402000001ba-1451934817.282862-850247339', '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 11:13:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 11:13:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:13:58 INFO - Using env: {'DISPLAY': ':0', 11:13:58 INFO - 'HOME': '/home/cltbld', 11:13:58 INFO - 'LANG': 'en_US.UTF-8', 11:13:58 INFO - 'LANGUAGE': 'en_US:en', 11:13:58 INFO - 'LOGNAME': 'cltbld', 11:13:58 INFO - 'MAIL': '/var/mail/cltbld', 11:13:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:58 INFO - 'MOZ_NO_REMOTE': '1', 11:13:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:58 INFO - 'NO_EM_RESTART': '1', 11:13:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:13:58 INFO - 'PWD': '/builds/slave/test-pgo', 11:13:58 INFO - 'SHELL': '/bin/bash', 11:13:58 INFO - 'SHLVL': '1', 11:13:58 INFO - 'TERM': 'linux', 11:13:58 INFO - 'TMOUT': '86400', 11:13:58 INFO - 'USER': 'cltbld', 11:13:58 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1451934817.282862-850247339', 11:13:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:58 INFO - '_': '/tools/buildbot/bin/python'} 11:13:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:58 INFO - Downloading/unpacking blobuploader==1.2.4 11:13: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 11:13: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 11:13: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 11:13: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 11:13: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 11:13: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 11:14:00 INFO - Downloading blobuploader-1.2.4.tar.gz 11:14:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 11:14:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:14:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:14: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 11:14: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 11:14: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 11:14: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 11:14: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 11:14: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 11:14:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 11:14:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 11:14:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:14: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 11:14: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 11:14: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 11:14: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 11:14: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 11:14: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 11:14:00 INFO - Downloading docopt-0.6.1.tar.gz 11:14:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 11:14:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 11:14:00 INFO - Installing collected packages: blobuploader, requests, docopt 11:14:00 INFO - Running setup.py install for blobuploader 11:14:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:14:00 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 11:14:00 INFO - Running setup.py install for requests 11:14:01 INFO - Running setup.py install for docopt 11:14:01 INFO - Successfully installed blobuploader requests docopt 11:14:01 INFO - Cleaning up... 11:14:01 INFO - Return code: 0 11:14:01 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:14:01 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')]} 11:14:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:01 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')]} 11:14:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:01 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 0x7ff0a9fe4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26be630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274f840>, '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 0x26bc6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26bcb60>, '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': '03627c79f6bb3d1578c4a402000001ba-1451934817.282862-850247339', '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 11:14:01 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 11:14:01 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 11:14:01 INFO - Using env: {'DISPLAY': ':0', 11:14:01 INFO - 'HOME': '/home/cltbld', 11:14:01 INFO - 'LANG': 'en_US.UTF-8', 11:14:01 INFO - 'LANGUAGE': 'en_US:en', 11:14:01 INFO - 'LOGNAME': 'cltbld', 11:14:01 INFO - 'MAIL': '/var/mail/cltbld', 11:14:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:01 INFO - 'MOZ_NO_REMOTE': '1', 11:14:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:01 INFO - 'NO_EM_RESTART': '1', 11:14:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:14:01 INFO - 'PWD': '/builds/slave/test-pgo', 11:14:01 INFO - 'SHELL': '/bin/bash', 11:14:01 INFO - 'SHLVL': '1', 11:14:01 INFO - 'TERM': 'linux', 11:14:01 INFO - 'TMOUT': '86400', 11:14:01 INFO - 'USER': 'cltbld', 11:14:01 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1451934817.282862-850247339', 11:14:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:01 INFO - '_': '/tools/buildbot/bin/python'} 11:14:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:14:01 INFO - Running setup.py (path:/tmp/pip-j2KdTm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:14:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:14:01 INFO - Running setup.py (path:/tmp/pip-SxDw1R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:14:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:14:01 INFO - Running setup.py (path:/tmp/pip-Pt7MH2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:14:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:14:01 INFO - Running setup.py (path:/tmp/pip-P2YndY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:14:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 11:14:01 INFO - Running setup.py (path:/tmp/pip-ZzWp77-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 11:14:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:14:01 INFO - Running setup.py (path:/tmp/pip-dVa2BJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:14:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:14:01 INFO - Running setup.py (path:/tmp/pip-5VQPYC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:14:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:14:02 INFO - Running setup.py (path:/tmp/pip-odX30p-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:14:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 11:14:02 INFO - Running setup.py (path:/tmp/pip-qFrnSe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 11:14:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 11:14:02 INFO - Running setup.py (path:/tmp/pip-2AhoCc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 11:14:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:14:02 INFO - Running setup.py (path:/tmp/pip-B6L53T-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:14:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:14:02 INFO - Running setup.py (path:/tmp/pip-sV9TNO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:14:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:14:02 INFO - Running setup.py (path:/tmp/pip-tBx9NC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:14:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:14:02 INFO - Running setup.py (path:/tmp/pip-7xv0AI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:14:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:14:02 INFO - Running setup.py (path:/tmp/pip-km6PCf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:14:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 11:14:02 INFO - Running setup.py (path:/tmp/pip-hxf32o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 11:14:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 11:14:02 INFO - Running setup.py (path:/tmp/pip-Eia6Ow-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 11:14:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:14:02 INFO - Running setup.py install for manifestparser 11:14:02 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 11:14:02 INFO - Running setup.py install for mozcrash 11:14:02 INFO - Running setup.py install for mozdebug 11:14:03 INFO - Running setup.py install for mozdevice 11:14:03 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 11:14:03 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 11:14:03 INFO - Running setup.py install for mozfile 11:14:03 INFO - Running setup.py install for mozhttpd 11:14:03 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 11:14:03 INFO - Running setup.py install for mozinfo 11:14:03 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 11:14:03 INFO - Running setup.py install for mozInstall 11:14:03 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 11:14:03 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 11:14:03 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 11:14:03 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 11:14:03 INFO - Running setup.py install for mozleak 11:14:03 INFO - Running setup.py install for mozlog 11:14:03 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 11:14:03 INFO - Running setup.py install for moznetwork 11:14:03 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 11:14:03 INFO - Running setup.py install for mozprocess 11:14:04 INFO - Running setup.py install for mozprofile 11:14:04 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 11:14:04 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 11:14:04 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 11:14:04 INFO - Running setup.py install for mozrunner 11:14:04 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 11:14:04 INFO - Running setup.py install for mozscreenshot 11:14:04 INFO - Running setup.py install for moztest 11:14:04 INFO - Running setup.py install for mozversion 11:14:04 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 11:14:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:14:04 INFO - Cleaning up... 11:14:04 INFO - Return code: 0 11:14:04 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:14:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:14:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:14:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:04 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 0x7ff0a9fe4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26be630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274f840>, '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 0x26bc6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26bcb60>, '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': '03627c79f6bb3d1578c4a402000001ba-1451934817.282862-850247339', '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 11:14:04 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 11:14:04 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 11:14:04 INFO - Using env: {'DISPLAY': ':0', 11:14:04 INFO - 'HOME': '/home/cltbld', 11:14:04 INFO - 'LANG': 'en_US.UTF-8', 11:14:04 INFO - 'LANGUAGE': 'en_US:en', 11:14:04 INFO - 'LOGNAME': 'cltbld', 11:14:04 INFO - 'MAIL': '/var/mail/cltbld', 11:14:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:04 INFO - 'MOZ_NO_REMOTE': '1', 11:14:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:04 INFO - 'NO_EM_RESTART': '1', 11:14:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:14:04 INFO - 'PWD': '/builds/slave/test-pgo', 11:14:04 INFO - 'SHELL': '/bin/bash', 11:14:04 INFO - 'SHLVL': '1', 11:14:04 INFO - 'TERM': 'linux', 11:14:04 INFO - 'TMOUT': '86400', 11:14:04 INFO - 'USER': 'cltbld', 11:14:04 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1451934817.282862-850247339', 11:14:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:04 INFO - '_': '/tools/buildbot/bin/python'} 11:14:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:14:04 INFO - Running setup.py (path:/tmp/pip-bq_XRm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:14:04 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)) 11:14:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:14:04 INFO - Running setup.py (path:/tmp/pip-8q7k6I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:14:04 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)) 11:14:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:14:04 INFO - Running setup.py (path:/tmp/pip-HhsBS6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:14:04 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)) 11:14:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:14:05 INFO - Running setup.py (path:/tmp/pip-DWznPc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:14:05 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)) 11:14:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 11:14:05 INFO - Running setup.py (path:/tmp/pip-UI9YeE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 11:14:05 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)) 11:14:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:14:05 INFO - Running setup.py (path:/tmp/pip-cZova4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:14:05 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)) 11:14:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:14:05 INFO - Running setup.py (path:/tmp/pip-gIGYa3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:14:05 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)) 11:14:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:14:05 INFO - Running setup.py (path:/tmp/pip-oPhQbF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:14:05 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)) 11:14:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 11:14:05 INFO - Running setup.py (path:/tmp/pip-qGhP0n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 11:14:05 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)) 11:14:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 11:14:05 INFO - Running setup.py (path:/tmp/pip-aSolzU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 11:14:05 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)) 11:14:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:14:05 INFO - Running setup.py (path:/tmp/pip-IHwctR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:14:05 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)) 11:14:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:14:05 INFO - Running setup.py (path:/tmp/pip-zuoxnF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:14:05 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)) 11:14:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:14:05 INFO - Running setup.py (path:/tmp/pip-c3bZJz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:14:05 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)) 11:14:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:14:05 INFO - Running setup.py (path:/tmp/pip-bod0VB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:14:05 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)) 11:14:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:14:05 INFO - Running setup.py (path:/tmp/pip-Gi6dKV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:14:05 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)) 11:14:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 11:14:05 INFO - Running setup.py (path:/tmp/pip-D9h2b3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 11:14:05 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)) 11:14:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 11:14:05 INFO - Running setup.py (path:/tmp/pip-BTfLcj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 11:14:06 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)) 11:14:06 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)) 11:14:06 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)) 11:14:06 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)) 11:14:06 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)) 11:14:06 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)) 11:14:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 11:14:06 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 11:14:06 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 11:14:06 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 11:14:06 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 11:14:06 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 11:14:06 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 11:14:07 INFO - Downloading blessings-1.5.1.tar.gz 11:14:07 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 11:14:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 11:14:07 INFO - Installing collected packages: blessings 11:14:07 INFO - Running setup.py install for blessings 11:14:07 INFO - Successfully installed blessings 11:14:07 INFO - Cleaning up... 11:14:07 INFO - Return code: 0 11:14:07 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 11:14:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 11:14:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 11:14:08 INFO - Reading from file tmpfile_stdout 11:14:08 INFO - Current package versions: 11:14:08 INFO - argparse == 1.2.1 11:14:08 INFO - blessings == 1.5.1 11:14:08 INFO - blobuploader == 1.2.4 11:14:08 INFO - docopt == 0.6.1 11:14:08 INFO - manifestparser == 1.1 11:14:08 INFO - mozInstall == 1.12 11:14:08 INFO - mozcrash == 0.16 11:14:08 INFO - mozdebug == 0.1 11:14:08 INFO - mozdevice == 0.47 11:14:08 INFO - mozfile == 1.2 11:14:08 INFO - mozhttpd == 0.7 11:14:08 INFO - mozinfo == 0.9 11:14:08 INFO - mozleak == 0.1 11:14:08 INFO - mozlog == 3.1 11:14:08 INFO - moznetwork == 0.27 11:14:08 INFO - mozprocess == 0.22 11:14:08 INFO - mozprofile == 0.28 11:14:08 INFO - mozrunner == 6.11 11:14:08 INFO - mozscreenshot == 0.1 11:14:08 INFO - mozsystemmonitor == 0.0 11:14:08 INFO - moztest == 0.7 11:14:08 INFO - mozversion == 1.4 11:14:08 INFO - psutil == 3.1.1 11:14:08 INFO - requests == 1.2.3 11:14:08 INFO - wsgiref == 0.1.2 11:14:08 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:14:08 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')]} 11:14:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:08 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')]} 11:14:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:08 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 0x7ff0a9fe4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26be630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274f840>, '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 0x26bc6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26bcb60>, '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': '03627c79f6bb3d1578c4a402000001ba-1451934817.282862-850247339', '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 11:14:08 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 11:14:08 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 11:14:08 INFO - Using env: {'DISPLAY': ':0', 11:14:08 INFO - 'HOME': '/home/cltbld', 11:14:08 INFO - 'LANG': 'en_US.UTF-8', 11:14:08 INFO - 'LANGUAGE': 'en_US:en', 11:14:08 INFO - 'LOGNAME': 'cltbld', 11:14:08 INFO - 'MAIL': '/var/mail/cltbld', 11:14:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:08 INFO - 'MOZ_NO_REMOTE': '1', 11:14:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:08 INFO - 'NO_EM_RESTART': '1', 11:14:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:14:08 INFO - 'PWD': '/builds/slave/test-pgo', 11:14:08 INFO - 'SHELL': '/bin/bash', 11:14:08 INFO - 'SHLVL': '1', 11:14:08 INFO - 'TERM': 'linux', 11:14:08 INFO - 'TMOUT': '86400', 11:14:08 INFO - 'USER': 'cltbld', 11:14:08 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1451934817.282862-850247339', 11:14:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:08 INFO - '_': '/tools/buildbot/bin/python'} 11:14:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:08 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)) 11:14:08 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)) 11:14:08 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)) 11:14:08 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)) 11:14:08 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)) 11:14:08 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)) 11:14:08 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)) 11:14:08 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)) 11:14:08 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)) 11:14:08 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)) 11:14:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 11:14:08 INFO - Cleaning up... 11:14:08 INFO - Return code: 0 11:14:08 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 11:14:08 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')]} 11:14:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:08 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')]} 11:14:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:08 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 0x7ff0a9fe4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26be630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274f840>, '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 0x26bc6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26bcb60>, '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': '03627c79f6bb3d1578c4a402000001ba-1451934817.282862-850247339', '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 11:14:08 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 11:14:08 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 11:14:08 INFO - Using env: {'DISPLAY': ':0', 11:14:08 INFO - 'HOME': '/home/cltbld', 11:14:08 INFO - 'LANG': 'en_US.UTF-8', 11:14:08 INFO - 'LANGUAGE': 'en_US:en', 11:14:08 INFO - 'LOGNAME': 'cltbld', 11:14:08 INFO - 'MAIL': '/var/mail/cltbld', 11:14:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:08 INFO - 'MOZ_NO_REMOTE': '1', 11:14:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:08 INFO - 'NO_EM_RESTART': '1', 11:14:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:14:08 INFO - 'PWD': '/builds/slave/test-pgo', 11:14:08 INFO - 'SHELL': '/bin/bash', 11:14:08 INFO - 'SHLVL': '1', 11:14:08 INFO - 'TERM': 'linux', 11:14:08 INFO - 'TMOUT': '86400', 11:14:08 INFO - 'USER': 'cltbld', 11:14:08 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1451934817.282862-850247339', 11:14:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:08 INFO - '_': '/tools/buildbot/bin/python'} 11:14:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:08 INFO - Downloading/unpacking jsonschema 11:14:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:14:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:14:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:14:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:14:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:14:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:14:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:14:10 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 11:14:10 INFO - Downloading/unpacking functools32 (from jsonschema) 11:14: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 11:14: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 11:14: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 11:14: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 11:14: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 11:14: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 11:14:10 INFO - Downloading functools32-3.2.3-2.tar.gz 11:14:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 11:14:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 11:14:10 INFO - warning: no files found matching '*.txt' 11:14:10 INFO - no previously-included directories found matching 'build' 11:14:10 INFO - no previously-included directories found matching 'dist' 11:14:10 INFO - no previously-included directories found matching '.git*' 11:14:10 INFO - Installing collected packages: jsonschema, functools32 11:14:10 INFO - Running setup.py install for functools32 11:14:10 INFO - warning: no files found matching '*.txt' 11:14:10 INFO - no previously-included directories found matching 'build' 11:14:10 INFO - no previously-included directories found matching 'dist' 11:14:10 INFO - no previously-included directories found matching '.git*' 11:14:10 INFO - Successfully installed jsonschema functools32 11:14:10 INFO - Cleaning up... 11:14:10 INFO - Return code: 0 11:14:10 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 11:14: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')]} 11:14:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14: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')]} 11:14:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff0a9fe4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26be630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274f840>, '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 0x26bc6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26bcb60>, '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': '03627c79f6bb3d1578c4a402000001ba-1451934817.282862-850247339', '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 11:14: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', 'flake8'] in /builds/slave/test-pgo/build 11:14: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 flake8 11:14:10 INFO - Using env: {'DISPLAY': ':0', 11:14:10 INFO - 'HOME': '/home/cltbld', 11:14:10 INFO - 'LANG': 'en_US.UTF-8', 11:14:10 INFO - 'LANGUAGE': 'en_US:en', 11:14:10 INFO - 'LOGNAME': 'cltbld', 11:14:10 INFO - 'MAIL': '/var/mail/cltbld', 11:14:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:10 INFO - 'MOZ_NO_REMOTE': '1', 11:14:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:10 INFO - 'NO_EM_RESTART': '1', 11:14:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:14:10 INFO - 'PWD': '/builds/slave/test-pgo', 11:14:10 INFO - 'SHELL': '/bin/bash', 11:14:10 INFO - 'SHLVL': '1', 11:14:10 INFO - 'TERM': 'linux', 11:14:10 INFO - 'TMOUT': '86400', 11:14:10 INFO - 'USER': 'cltbld', 11:14:10 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1451934817.282862-850247339', 11:14:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:10 INFO - '_': '/tools/buildbot/bin/python'} 11:14:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:10 INFO - Downloading/unpacking flake8 11:14: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 11:14: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 11:14: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 11:14: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 11:14: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 11:14: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 11:14:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:14:12 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 11:14:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:14: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 11:14: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 11:14: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 11:14: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 11:14: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 11:14: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 11:14:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:14:12 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 11:14:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:14: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 11:14: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 11:14: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 11:14: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 11:14: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 11:14: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 11:14:12 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 11:14:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:14: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 11:14: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 11:14: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 11:14: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 11:14: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 11:14: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 11:14:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 11:14:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 11:14:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:14:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:14:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:14:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:14:13 INFO - no previously-included directories found matching 'docs/_build' 11:14:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:14:13 INFO - Running setup.py install for pep8 11:14:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:14:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:14:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:14:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:14:13 INFO - no previously-included directories found matching 'docs/_build' 11:14:13 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 11:14:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:14:13 INFO - Cleaning up... 11:14:13 INFO - Return code: 0 11:14:13 INFO - Running post-action listener: _resource_record_post_action 11:14:13 INFO - Running post-action listener: _start_resource_monitoring 11:14:13 INFO - Starting resource monitoring. 11:14:13 INFO - ##### 11:14:13 INFO - ##### Running install step. 11:14:13 INFO - ##### 11:14:13 INFO - Running pre-action listener: _resource_record_pre_action 11:14:13 INFO - Running main action method: install 11:14:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 11:14:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 11:14:13 INFO - Reading from file tmpfile_stdout 11:14:13 INFO - Detecting whether we're running mozinstall >=1.0... 11:14:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 11:14:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 11:14:13 INFO - Reading from file tmpfile_stdout 11:14:13 INFO - Output received: 11:14:13 INFO - Usage: mozinstall [options] installer 11:14:13 INFO - Options: 11:14:13 INFO - -h, --help show this help message and exit 11:14:13 INFO - -d DEST, --destination=DEST 11:14:13 INFO - Directory to install application into. [default: 11:14:13 INFO - "/builds/slave/test-pgo"] 11:14:13 INFO - --app=APP Application being installed. [default: firefox] 11:14:13 INFO - mkdir: /builds/slave/test-pgo/build/application 11:14:13 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'] 11:14:13 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 11:14:30 INFO - Reading from file tmpfile_stdout 11:14:30 INFO - Output received: 11:14:30 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 11:14:30 INFO - Running post-action listener: _resource_record_post_action 11:14:30 INFO - ##### 11:14:30 INFO - ##### Running run-tests step. 11:14:30 INFO - ##### 11:14:30 INFO - Running pre-action listener: _resource_record_pre_action 11:14:30 INFO - Running main action method: run_tests 11:14:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 11:14:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 11:14:30 INFO - Python 2.7.3 11:14:30 INFO - Return code: 0 11:14:30 INFO - grabbing minidump binary from tooltool 11:14:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:14:30 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 0x274f840>, '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 0x26bc6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26bcb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 11:14:30 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 11:14:30 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 11:14:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:14:30 INFO - Return code: 0 11:14:30 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 11:14:30 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 11:14:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 11:14:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 11:14:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 11:14:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 11:14:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 11:14:31 INFO - Return code: 0 11:14:31 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/DOZITRv2QXKgWGk0fmwpsQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 11:14:31 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/DOZITRv2QXKgWGk0fmwpsQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --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 11:14:31 INFO - Using env: {'DISPLAY': ':0', 11:14:31 INFO - 'HOME': '/home/cltbld', 11:14:31 INFO - 'LANG': 'en_US.UTF-8', 11:14:31 INFO - 'LANGUAGE': 'en_US:en', 11:14:31 INFO - 'LOGNAME': 'cltbld', 11:14:31 INFO - 'MAIL': '/var/mail/cltbld', 11:14:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 11:14:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 11:14:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:31 INFO - 'MOZ_NO_REMOTE': '1', 11:14:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 11:14:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:31 INFO - 'NO_EM_RESTART': '1', 11:14:31 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:14:31 INFO - 'PWD': '/builds/slave/test-pgo', 11:14:31 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 11:14:31 INFO - 'SHELL': '/bin/bash', 11:14:31 INFO - 'SHLVL': '1', 11:14:31 INFO - 'TERM': 'linux', 11:14:31 INFO - 'TMOUT': '86400', 11:14:31 INFO - 'USER': 'cltbld', 11:14:31 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1451934817.282862-850247339', 11:14:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:31 INFO - '_': '/tools/buildbot/bin/python'} 11:14:31 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/DOZITRv2QXKgWGk0fmwpsQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 11:14:31 INFO - mozversion application_buildid: 20160104083143 11:14:31 INFO - mozversion application_changeset: 9d5029646b5297649513b648d9109f20fdab9845 11:14:31 INFO - mozversion application_display_name: Nightly 11:14:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:14:31 INFO - mozversion application_name: Firefox 11:14:31 INFO - mozversion application_remotingname: firefox 11:14:31 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:14:31 INFO - mozversion application_vendor: Mozilla 11:14:31 INFO - mozversion application_version: 46.0a1 11:14:31 INFO - mozversion platform_buildid: 20160104083143 11:14:31 INFO - mozversion platform_changeset: 9d5029646b5297649513b648d9109f20fdab9845 11:14:31 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:14:31 INFO - mozversion platform_version: 46.0a1 11:14:31 INFO - using testdate: 1451934871 11:14:31 INFO - actual date: 1451934871 11:14:31 INFO - starting webserver on 'localhost:49092' 11:14:31 INFO - SUITE-START | Running 3 tests 11:14:31 INFO - TEST-START | dromaeo_css 11:14:31 INFO - operating with platform_type : linux_ 11:14:31 INFO - Initialising browser for dromaeo_css test... 11:14:31 INFO - TEST-INFO | started process 22862 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpoFsQlc/profile http://localhost:49092/getInfo.html) 11:14:35 INFO - PROCESS | 22862 | __metrics Screen width/height:1600/1200 11:14:35 INFO - PROCESS | 22862 | colorDepth:24 11:14:35 INFO - PROCESS | 22862 | Browser inner width/height: 1024/697 11:14:35 INFO - PROCESS | 22862 | __metrics 11:14:35 INFO - PROCESS | 22862 | 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:14:35 INFO - PROCESS | 22862 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:14:36 INFO - TEST-INFO | 22862: exit 0 11:14:36 INFO - Browser initialized. 11:14:36 INFO - Running cycle 1/1 for dromaeo_css test... 11:14:36 INFO - TEST-INFO | started process 22956 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpoFsQlc/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:14:48 INFO - PROCESS | 22956 | RSS: Main: 149864448 11:14:48 INFO - PROCESS | 22956 | 11:15:39 INFO - PROCESS | 22956 | 1451934939368 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] 11:17:48 INFO - PROCESS | 22956 | Cycle 1(1): loaded http://localhost:49092/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49092/tests/dromaeo/cssquery-ext.html) 11:17:49 INFO - PROCESS | 22956 | RSS: Main: 276733952 11:17:49 INFO - PROCESS | 22956 | 11:20:51 INFO - PROCESS | 22956 | Cycle 1(1): loaded http://localhost:49092/tests/dromaeo/cssquery-ext.html (next: http://localhost:49092/tests/dromaeo/cssquery-jquery.html) 11:20:52 INFO - PROCESS | 22956 | RSS: Main: 233631744 11:20:52 INFO - PROCESS | 22956 | 11:23:54 INFO - PROCESS | 22956 | Cycle 1(1): loaded http://localhost:49092/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49092/tests/dromaeo/cssquery-mootools.html) 11:23:54 INFO - PROCESS | 22956 | RSS: Main: 230346752 11:23:54 INFO - PROCESS | 22956 | 11:26:56 INFO - PROCESS | 22956 | Cycle 1(1): loaded http://localhost:49092/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49092/tests/dromaeo/cssquery-prototype.html) 11:26:57 INFO - PROCESS | 22956 | RSS: Main: 216285184 11:26:57 INFO - PROCESS | 22956 | 11:29:59 INFO - PROCESS | 22956 | Cycle 1(1): loaded http://localhost:49092/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49092/tests/dromaeo/cssquery-yui.html) 11:30:00 INFO - PROCESS | 22956 | RSS: Main: 219582464 11:30:00 INFO - PROCESS | 22956 | 11:33:02 INFO - PROCESS | 22956 | Cycle 1(1): loaded http://localhost:49092/tests/dromaeo/cssquery-yui.html (next: http://localhost:49092/tests/dromaeo/cssquery-dojo.html) 11:33:03 INFO - PROCESS | 22956 | RSS: Main: 263843840 11:33:03 INFO - PROCESS | 22956 | 11:33:03 INFO - PROCESS | 22956 | __start_tp_report 11:33:03 INFO - PROCESS | 22956 | _x_x_mozilla_page_load 11:33:03 INFO - PROCESS | 22956 | _x_x_mozilla_page_load_details 11:33:03 INFO - PROCESS | 22956 | |i|pagename|runs| 11:33:03 INFO - PROCESS | 22956 | |0;dojo.html;3056.5567992641068;3112.05082449853;3161.367726454708;3161.8260995645232;3184.697453741895;5175.120229560975;5251.054810134175;5255.421903590602;5273.050850846846;5310.4158542560335;5250.501202385777;5275.736213189335;5304.973475132629;5316.627836051478;5325.334333208349;4630.421197350332;4769.070031343889;4776.235802271629;4833;4911.8772030699165;4711.246200607903;4862.17343051682;4878.048780487807;4916.3608730864935;4938.604911607081;4804.783784729696;4805.399325084364;4913.729744864031;4936.827211047596;4940.061388336205;4808.711477311373;4809.182438985381;4826.251930950708;4839.854804355875;4846.709197448165;4745.572898439123;4775.689580177312;4786.066716990188;4825.420949486049;4864.173090574611;4998.150314446553;5104.3109180260935;5115.872103197413;5200.921986170172;5231.163013917793;5697.658140511541;5702.201691763156;5704.629199102045;5709.571782116358;5712.742926568273;5557.444255574451;5701.116326969326;5754.108113242454;5758.193852860602;5759.539236861041;5225.242339860737;5279.102552566034;5292.867678308035;5334.199870019451;5381.031414345416;5781.942180578225;5796.449337312949;5801.3908539602735;5814.186013958049;5823.708814559255;5433.918491222635;5554.055810512223;5565.66606003633;5575;5582.7766889323975;5554.805581804618;5610.270664813548;5634.126710359901;5725.227094342211;5731;5625;5635.718214089361;5643.463870932255;5644.463775941279;5647.519960803378;5549.556035517149;5649.576281778883;5653.886922261532;5657.773689052392;5658.34928983164;4357.2592659248;4397.560243975641;4410.0738844842945;4416.779161041999;4434.5343738907595;3937.4881265435884;3951.8419263229725;3956.604339566078;3989.4215338776294;3991.560928297885;5344.225087362311;5345.38528069277;5350.170723537858;5350.197470379474;5358.490943360374;5587.469190426903;5596.748146333425;5656.208130861683;5692.0608099663095;5722.685252311163;5228.058949389147;5250.002499525154;5250.868728281747;5261.921071183859;5300.496452836975;4838.274258861128;4840.491748366371;4844.176489996709;4847.854564363075;4878.536539028786;5742.425757424307;5783.508401785895;5829.854253643693;5832.096025116114;5848.181254624356;5650.463205995424;5683.175939488834;5692.943070569241;5705.800296989585;5734.168545560954;5885.087811389241;5892.469677729025;5893.2044174035955;5893.734781934909;5900.468957793819;5446.237526746338;5564.721763911869;5583.972080139573;5628.577856660685;5681.971590142023;5642.71786410686;5656.6888821115235;5682.9147562785765;5688.63023903445;5689;5530;5568.053430916673;5589.105743081088;5596.888062238651;5599.524040456607;5457.61796674229;5551;5567.220589117608;5577.27495425592;5662.235598194356;5504.614676972574;5517.089680202722;5525.281713377235;5526.253955715927;5526.336839579276;5563.332400112013;5588.161775733673;5602.271704678529;5610.859728506657;5664.122061080539;5361.410244873139;5469.206964989975;5473.261109750292;5477.726113694379;5493.862653433696 11:33:03 INFO - PROCESS | 22956 | |1;ext.html;547.2857920413861;556.0325034440076;560.8457674139613;570.4837122404224;575.3556017260669;27909.302267443298;28663.283417914536;28729.138125856232;36108;36835.81582092092;39268.41097383542;39392.409113863316;39526.8023659882;39603.80198099012;39675.603243967555;8446.239838414542;8615.913840861574;8631.568421578928;8633.611487483047;8635.309175265964;7538.623068846563;7692.653830577638;9774.90225097747;10002.34984725994;10004.649837255698;9811.166050885684;9967.501624918725;9972.10251077403;9978.800423991515;9981.50092495376;7612.7716168515035;7789.9221007789765;9822.312438129335;9934.45360505172;9943.552540135675;9916.157126644244;10159.187265018782;10164.0344167304;10166.745831354201;10167.89832101677;36724;37173.442398364044;37192;37210;37217.81391093027;2906.8837246510116;2941.691122432135;2971.509700899349;3066.693330666938;3635.527381440396;28651.426971460663;29999.100026999226;30039.249018774488;30088.398232035237;30367.696323036707;3758.1544152565725;3841.1707181470147;3845.4616353710503;3906.257811015898;4102.712810103294;263202;264432;264510;264920;265092;51044.23433648498;51950.76590809127;57677.42322576804;58280.12579811221;58975;53032.469675303524;53041;53201.46798531965;53314.20028699573;53328.73335633297;14817.70364592702;14888.776668349983;14920.552383428514;14981.850181498046;15026.098434093989;11204.327740335606;11251.212415130862;11292.15308851823;11314.717132071764;11393.202475826778;18879.716804247946;18904.432867013737;18996.715049274273;19056.904715476336;19075.809241907682;7402.596753808025;7634.427417943676;7702.807429814299;7709.653065612061;7794;901.6078006067381;961.1637875048752;964.9324547281623;1029.325791606499;1136.670365593985;27969.72030279712;28008.71991280061;28884.27789305284;28909.85545072261;29025.85487072551;1025.5231317437429;1110.8000559899297;1135.432283858071;1170.1224081938547;1189.5598628507335;14817.925910370379;14912.47806326795;14940.32768525419;15015.699686006219;15073.849261507245;313338;315987;317101;318203;319359;51870.48129518732;52226.73886630542;52243.21635175475;52248;52325.2151217732;1296.4230917241737;1300.479808076758;1316.3352506984104;1318.2881244128255;1328.249539010456;22566.548669026855;28442.573361399183;28761.856190718914;28807.855960720062;29204;45151.54848451474;45674;45752.771236143606;45756.54243457656;45761.08477830491;236939;238646;238752;239055;239360;27387.726122739314;27800;29316.7068329314;31179.376412472076;31760.523592146597;36628.0842978917;36929.815350923076;37508.624913750515;37652.81173594115;37855.81072094622;31591.88813704981;32217.35565288634;32307.35385292328;32665.34669306648;33971.83014084914;28422.28944276327;33229.66770332266;33421.33157336791;34320.48519272263;36553.45169822402;31320.21699457532;31956.36087278288;32047.679523205403;32141.196470088435;32148.678513215506;28212.576811347437;30949.535756963214;31077.22306942254;31255.84372078125;31649.525257121622;24067.398315042265;24106.39734006664;24136.396590084685;24152.396190095387;24408 11:33:03 INFO - PROCESS | 22956 | |2;jquery.html;365.65993625927894;368.2689860626656;368.4767629965449;370.3870094992788;370.8887333799861;13569.932150339258;13644.590662280123;16429.671406571877;16889.32442702292;17514.47456576303;15449.845501544982;15623.21883905803;15903.363865445397;15949.920250398733;16016.75974860378;5368.731563421833;5519.530839878616;5522.66863988162;5524.972375138119;5526.723663816813;4103.897402564945;4211.1998720243055;5452.863678408032;5499.477549632778;5885.117232415129;6001.129836173752;6031.1254868044325;6046.1837651917085;6052.394760523956;6058.182145410379;5090.33825602673;5262.973685131569;5300.708461034642;5304.230886521472;6010.36891126432;5072.340595722532;5087.414947281073;5097.23541468779;5097.974510127463;5373.1402975524115;12314.876851231462;12396.194247373982;12642.683932901751;12670.429830657642;13228.603141905758;1949.717290992798;2003.278819624934;2047.7747447780732;2065.9380218593465;2124.192806733447;8854.513001784899;9072.682456114071;9205.539723013822;9561.904380956172;9605.607186957852;1540.9691806163814;1544.6087786259516;1606.9517914462585;1635.3049953769719;1672.0385778177597;55412.16881746777;56017.71991140059;56640.150397744066;57437.42562574363;57739.42260577424;9823.312368134304;10181.134603558632;10366.948165259277;10465.47672616366;10512.947435262928;13574.389152488162;13645.044846860625;13652.522161724492;13659.112157709716;13668.589942301747;7449.292317229854;7486.700531978769;7524;7545.50954187987;7583.317501424898;7163.964180179066;7174.852023676187;7185.281471852877;7225.2774722528375;7226.602536860523;4435.534268901783;4498.797554110073;4517.706349087299;4533.455985281721;4540.364348991144;1743.4508129939281;1778.9644207115784;1789.2664007757016;1791.5968906996081;1838.2738818167018;833.8749187621784;893.5398269891011;901.2159421303377;997.486294558303;1069.5882085397022;16457.670846583;16939;17203.82796172047;17300.22149003298;17534.473965781046;895.8253140637513;902.0708670069838;921.0881227584777;927.7170463008847;979.8383266760904;6097.5731698780655;6526.314736952647;9506.667266645634;9947.154491868272;9979.800403992025;609479;630671;635691.3938872762;640185;646590;78688.60655696684;81954.18045819465;82915;83011.5849420749;83931;519.3559985617807;525.0391783037034;526.0137242669994;526.7892842862885;527.4751622135999;10726.51730672106;10864.402457864893;10912;10931.344119352865;10940.617078402218;36056;36270.4559431614;37289.62710372861;37568.81215593904;37593.2481350366;46845.2973205409;47577.76211118922;48692.26961595508;49035;50166;13807.930960345135;14201.147931124166;14342.856571434151;14375.640608984859;14583.85416145825;16895;17315.7402638958;17355.56611084733;17584.296628135242;18230.17964191641;13901.930490347484;14363.281835908372;14383.856161438252;14505;14952.775708364166;14155.64610884736;14406.85593144097;14966.625834354229;15670;15730.9213453932;14553.27233638335;14638.634034149232;14673.779893301395;15041.473548425753;15204.771928421304;14036.929815350857;14230.288485575473;14322.355494002586;14335.85664143387;14425.206613635932;13542.864571354161;13720.588382348546;13974.510892118727;14409.279536023367;14568.635784105481 11:33:03 INFO - PROCESS | 22956 | |3;mootools.html;1315.8223639808634;1449.1667291307497;1465.282011814211;1630.339712416471;1835.5044138082717;7053.541519801216;7708.1906399827985;7893.763187104389;7914.1294457609765;7920.089189743181;7756.689732410697;7895.0920644125945;7936.76189714308;7948.085970113439;7953.72161974331;1989.7413336266266;2002.5594369238745;2033.085111699741;2245.955080898381;2282.1213832674457;2284.6230371988604;2330.8951097200666;2331.94170145746;2333.7549557296493;2333.7782910623464;2235.117128734149;2257.480779420734;2263.6830843681814;2277.0436416705024;2285.1430713482446;2237.9776202238013;2239.361781892161;2259.6610508423705;2289.461976435536;2305.250793492105;2293.048384920256;2296.1159953417887;2321.9071237150492;2323.3494621506006;2324.825638077151;7841.411894107965;7897.2497612727275;7900.367970562341;7903.644336004893;7913.050433947906;4661.650376221797;4742.430908290993;4761.333413322138;4762.071396077767;4764.452088009889;3139.9372012559847;3144.4025635129483;3185.140012196717;3187.792793468417;3237.14215732831;990.6334656177261;1034.2088302448633;1039.225776796284;1088.3687461272443;1109.1958330210614;11032;11038.724031899186;11041.33751974876;11045.723856903642;11051.778964420666;4245.787710614457;4321.632661223831;4346.326319420495;4367.039251364695;4369.191699535596;9323.90676093244;9341.159295663423;9357.485338306322;9370;9370.718878433658;4779.378680771547;4820.831270905502;4821.349117869113;4827.372441582642;4831.830885918976;4357.302831546937;4375.234333991539;4384.12317536494;4393.912121757547;4397.780110994501;3329.5338652588657;3354.3794398036443;3611.1513794258326;3620.7646502977223;3660.7071434285194;1140.133498541098;1162.3084264862393;1167.3171194850938;1192.1595275331044;1202.6271855724578;863.369740089738;863.8099618084011;864.3085531574715;895.4940458640847;937.386012162035;7138.179109402485;7188.101487314086;7219.133703955559;7240.855182896313;7347.302006309392;1032.4785983078498;1044.9268551201494;1059.9046085852156;1070.983935240972;1109.6005438042298;5447.836564903059;5496.697681627549;5510.118381059011;5512.4211957744665;5513.145462453326;8823.867641985375;8913.955430222808;9039.457632541937;9321.06789321076;9353.204977576846;9254.259659227246;9353.859692104625;9357.578908949114;9357.859632105525;9361.251099911991;7371.741989030358;7476.887846682304;7494.288042635941;7568.053993250844;7607.467477276648;7027.4729395294535;7042.7887163385185;7049.612271325126;7050.717971281091;7053.294670533111;8441.451305665112;8505.149485051445;8524.062353141273;8600.483970961763;8694.130586941255;8660.78348041304;8836.513991730259;8849.20357167858;9052.275817934682;9077.954610226907;6220.253569571681;6374.649394283173;6387.489000880011;6390.073439351361;6390.392912673288;6490.935090649033;6653.933460665525;6942.479314051568;7070.292970702889;7084.752033678797;6775.695093720696;6809.148856392951;6876.621785801829;6954.756583519553;6976.965115174595;6464.450521705708;6527.51043671717;6612.239592446737;6626.469882409492;6724.697388617426;6096.146539484387;6124.203853499017;6132.938670613236;6137.96931015342;6139.877202456015;5717.1995920570325;5932.5550583705535;5981.3719559445635;5983.6237665338085;5987.43119403656;5902.5277977762535;5930.377310382521;5940.376260492586;5941;5957.49361304294 11:33:03 INFO - PROCESS | 22956 | |4;prototype.html;343.07027954243995;349.47404156744096;350.4987867349692;354.8962725922381;355.2841025333954;5863.79476718315;5931.377205393436;5964.761409543613;5989.490893274066;5993.46058854703;5602.579806514517;5683.403242659513;5730.226419433376;5854.268216472941;5870.26621672291;4516.367708520794;4549.954500454986;4562.270036794113;4566.862994110182;4585.403897493321;4557.156925968707;4571.657125715568;4577.382053422779;4580.083983203356;4580.221362368388;4304.440422745039;4396.472423309191;4397.428334316551;4461.308497182926;4500.302453119772;4477.26125189345;4483.170613436492;4492.415985921842;4494.640428765691;4497.10057988402;4014.979925100356;4026.255142798592;4027.496562929634;4030.0730831908827;4034.8789536313957;5602.551795856321;5602.747876345574;5603.467670571289;5608.46719561641;5614.578906582023;5171.663841850268;5293.814716484904;5308.442613525563;5317.255584218213;5318.601104917147;6123.755049798003;6166.229221347332;6171.506279497629;6176.96911515444;6177.7837775677635;4484.798184081724;4488.192125417424;4489.9775501122285;4494.662900282492;4506.053728716974;6289.528285378615;6516.804495865132;6517.967410162919;6519.511036672268;6540.869182616369;4493.865184044484;4525.343825145335;4525.909481810411;4529.207388707029;4529.547045295444;4570.748608826547;4571.268597024527;4588.128255631419;4588.242939914943;4592.954070459319;5243.2659427680155;5247.632665713363;5250.369955605352;5254.894902102013;5254.92117618236;6067.787627433018;6257.061440783918;6268.216472940882;6298.905516417258;6310.6213627182515;1593.6254980079673;1614.6932082904211;1614.8292487946146;1616.1434439746954;1617.6683779825107;1063.9042486176127;1070.796548655753;1081.9242653014371;1086.1093902999464;1100;5944.3164036136395;5955.851103722442;5977;5979.880402391927;5985.850353741104;6476.643784591893;6476.740930362827;6478.611283322922;6479.514036447285;6481.189851268591;5785.103308987113;5850.64896106235;5928.970355148197;5980.401959804072;6044.546659000593;3498;3507.14075051614;3517.9296414071573;3525.3125640499857;3528.4530897710897;6719.764808231688;6745.59526428406;6752;6755;6755.932440675629;6568.310327415553;6663.700133494004;6670.866582668416;6692.899606505906;6695.531312808057;6670.132882725215;6673.499487538454;6694.564853284521;6734.191896972395;6737.663116844138;6457.806265812033;6501.609903405811;6502.479801615765;6513.804585862432;6519.152510173647;6328.6202827830475;6437.645929473737;6449.935500644933;6457.773977910751;6458.580192287486;6737.056812046416;6745.190577130776;6751.358620931003;6755.189377274758;6757.864842703217;4551.749653768942;4556.587457888066;4556.772161391984;4557;4558.680892337505;6357.650329231937;6519.250286217146;6520;6532.934670653232;6534.509911756732;6340.619562826245;6352.110704501281;6357.650329231752;6362.236531616236;6364.236291645032;6273.686315684289;6326.2092238470195;6340.365963403623;6342.682865856596;6345.302016778059;5994.520438365008;6177.9691101546005;6179.536534759821;6223.190985171898;6225.470834978896;6291.96854015727;6315.115883776367;6372.36276372359;6380.202474690664;6393.1688880445245;6234.719437625408;6238.313785483684;6242.250929888442;6246.406591373812;6247.2815626201755 11:33:03 INFO - PROCESS | 22956 | |5;yui.html;677.7289084366253;698.53547390985;715.5956884360335;766.2796970847406;803.7146812881423;11992.820107698391;12154.756904861919;12163.148579599432;12182.878171218284;12211.389430528472;11199.384033878154;11263.380514071723;11272.041876440513;11280;11286.98417142459;682.0519477925687;682.6723172877022;807.6123460738849;814.6659869453525;831.7296878514506;827;828.1221904780922;834.2033358142959;835.1898658301438;835.5863847395517;866.6706651472432;874.7463235661651;875.1817051057282;875.483464755794;875.7941883657336;712.3161764705889;714.8963400306952;836.0343802907621;864.3301441382915;866.0430224601787;633.9461145802612;634.7587916591712;638.5625846295303;638.9904151437732;639.5970538560676;11395.54417823286;11396.373199474026;11467.36929468879;11474.713132171679;11485.94257028718;10415.843762343571;10491.265611407205;10518.158547316196;10912.56349746017;11323.547058117665;9541.33210675253;9707.563159657762;9738.367006144577;9767.267454940908;9908.851367229498;3478.4608385700003;3517.7009954153673;3540.822958852073;3543.5216245806746;3609.8014609196484;46566.5343346569;46640.300395494094;46667.76666116682;46757.766211169066;46762.766186168854;9095.909040909639;9135.13216244469;9190.49452280131;9291.394256862746;9389.295802814817;18575.628487430175;18591.16339764687;18602.906985464986;18627.90686046561;18649;6934.514583979174;7170.211276759553;7281.927180728231;7302.780916572511;7360.631968401559;3532.5054492371087;3565.750397472152;3575.76757510761;3608.585012723518;3629.129009037812;2989.59640448541;3005.128512731327;3006.4738670732536;3010.5484177373132;3030.499967505337;546.3416583017455;547.8630342414397;556.6743455078824;568.8208214412447;582.5310624946874;504.8359283232964;581.9272590926134;595.8063629320488;603.6649659439054;617.8362733875526;7377.483576149725;7712.614369281513;7988;8091.514509129471;8413.621387037598;494.5153749325681;537.1191246355979;543.8857839853675;571.0919637775874;631.8009826904511;3421.4012547804036;3512.613612502623;3693.3351996640326;3722.758020728644;3754.887353379403;53685;54163;54213.186802198;54391.728041359536;54526.72736636292;49754;50796.492035079915;50911.490885091414;50918.745406273476;51354;45061.09877802491;45662.086758265315;46627.30059049117;47321.526784731715;49919.50080499221;7517.624118794148;7519;7608.771736847903;7723.922760772545;7857.174996625501;33388.499172512915;33935.83032084824;34160.48759268563;34172.82913585416;34182.487262691575;40326.1934761309;40711;41179.7941010305;44921.10157796891;45011.774941125084;9692.224622030362;9717.757056073655;9881;9893.55479003461;10191.439470829175;10958.56165753361;10986.670399888017;11042;11551.8794448008;11553.422328883691;9830.950845245728;10004.499775011365;10112.544935477774;10280.742981425525;10292.691219263434;9336.486493242937;9544.809103818023;9743.756406089904;9997.700068997941;9997.750056248651;9775.951120244354;10136.290459668047;10304.381737095799;10317.74205644865;10641.14870810318;8500.319974402157;8574.22831945128;8633.76187479391;8634.913650863411;8798.296136309207;7750.379969602531;8116.634751436081;8228.547429891414;8296.585170741319;8296.728169973972 11:33:03 INFO - PROCESS | 22956 | __end_tp_report 11:33:03 INFO - PROCESS | 22956 | __start_cc_report 11:33:03 INFO - PROCESS | 22956 | _x_x_mozilla_cycle_collect,1002 11:33:03 INFO - PROCESS | 22956 | __end_cc_report 11:33:03 INFO - PROCESS | 22956 | __startTimestamp1451935983196__endTimestamp 11:33:03 INFO - PROCESS | 22956 | 11:33:03 INFO - PROCESS | 22956 | ------- Summary: start ------- 11:33:03 INFO - PROCESS | 22956 | Number of tests: 6 11:33:03 INFO - PROCESS | 22956 | 11:33:03 INFO - PROCESS | 22956 | [#0] dojo.html Cycles:165 Average:5266.44 Median:5493.86 stddev:580.73 (10.6%) stddev-sans-first:556.04 11:33:03 INFO - PROCESS | 22956 | Values: 3056.6 3112.1 3161.4 3161.8 3184.7 5175.1 5251.1 5255.4 5273.1 5310.4 5250.5 5275.7 5305.0 5316.6 5325.3 4630.4 4769.1 4776.2 4833.0 4911.9 4711.2 4862.2 4878.0 4916.4 4938.6 4804.8 4805.4 4913.7 4936.8 4940.1 4808.7 4809.2 4826.3 4839.9 4846.7 4745.6 4775.7 4786.1 4825.4 4864.2 4998.2 5104.3 5115.9 5200.9 5231.2 5697.7 5702.2 5704.6 5709.6 5712.7 5557.4 5701.1 5754.1 5758.2 5759.5 5225.2 5279.1 5292.9 5334.2 5381.0 5781.9 5796.4 5801.4 5814.2 5823.7 5433.9 5554.1 5565.7 5575.0 5582.8 5554.8 5610.3 5634.1 5725.2 5731.0 5625.0 5635.7 5643.5 5644.5 5647.5 5549.6 5649.6 5653.9 5657.8 5658.3 4357.3 4397.6 4410.1 4416.8 4434.5 3937.5 3951.8 3956.6 3989.4 3991.6 5344.2 5345.4 5350.2 5350.2 5358.5 5587.5 5596.7 5656.2 5692.1 5722.7 5228.1 5250.0 5250.9 5261.9 5300.5 4838.3 4840.5 4844.2 4847.9 4878.5 5742.4 5783.5 5829.9 5832.1 5848.2 5650.5 5683.2 5692.9 5705.8 5734.2 5885.1 5892.5 5893.2 5893.7 5900.5 5446.2 5564.7 5584.0 5628.6 5682.0 5642.7 5656.7 5682.9 5688.6 5689.0 5530.0 5568.1 5589.1 5596.9 5599.5 5457.6 5551.0 5567.2 5577.3 5662.2 5504.6 5517.1 5525.3 5526.3 5526.3 5563.3 5588.2 5602.3 5610.9 5664.1 5361.4 5469.2 5473.3 5477.7 5493.9 11:33:03 INFO - PROCESS | 22956 | 11:33:03 INFO - PROCESS | 22956 | [#1] ext.html Cycles:180 Average:43480.00 Median:174981.76 stddev:71834.75 (41.1%) stddev-sans-first:71963.94 11:33:03 INFO - PROCESS | 22956 | Values: 547.3 556.0 560.8 570.5 575.4 27909.3 28663.3 28729.1 36108.0 36835.8 39268.4 39392.4 39526.8 39603.8 39675.6 8446.2 8615.9 8631.6 8633.6 8635.3 7538.6 7692.7 9774.9 10002.3 10004.6 9811.2 9967.5 9972.1 9978.8 9981.5 7612.8 7789.9 9822.3 9934.5 9943.6 9916.2 10159.2 10164.0 10166.7 10167.9 36724.0 37173.4 37192.0 37210.0 37217.8 2906.9 2941.7 2971.5 3066.7 3635.5 28651.4 29999.1 30039.2 30088.4 30367.7 3758.2 3841.2 3845.5 3906.3 4102.7 263202.0 264432.0 264510.0 264920.0 265092.0 51044.2 51950.8 57677.4 58280.1 58975.0 53032.5 53041.0 53201.5 53314.2 53328.7 14817.7 14888.8 14920.6 14981.9 15026.1 11204.3 11251.2 11292.2 11314.7 11393.2 18879.7 18904.4 18996.7 19056.9 19075.8 7402.6 7634.4 7702.8 7709.7 7794.0 901.6 961.2 964.9 1029.3 1136.7 27969.7 28008.7 28884.3 28909.9 29025.9 1025.5 1110.8 1135.4 1170.1 1189.6 14817.9 14912.5 14940.3 15015.7 15073.8 313338.0 315987.0 317101.0 318203.0 319359.0 51870.5 52226.7 52243.2 52248.0 52325.2 1296.4 1300.5 1316.3 1318.3 1328.2 22566.5 28442.6 28761.9 28807.9 29204.0 45151.5 45674.0 45752.8 45756.5 45761.1 236939.0 238646.0 238752.0 239055.0 239360.0 27387.7 27800.0 29316.7 31179.4 31760.5 36628.1 36929.8 37508.6 37652.8 37855.8 31591.9 32217.4 32307.4 32665.3 33971.8 28422.3 33229.7 33421.3 34320.5 36553.5 31320.2 31956.4 32047.7 32141.2 32148.7 28212.6 30949.5 31077.2 31255.8 31649.5 24067.4 24106.4 24136.4 24152.4 24408.0 11:33:03 INFO - PROCESS | 22956 | 11:33:03 INFO - PROCESS | 22956 | [#2] jquery.html Cycles:180 Average:31363.01 Median:370.64 stddev:103280.54 (27865.6%) stddev-sans-first:103544.04 11:33:03 INFO - PROCESS | 22956 | Values: 365.7 368.3 368.5 370.4 370.9 13569.9 13644.6 16429.7 16889.3 17514.5 15449.8 15623.2 15903.4 15949.9 16016.8 5368.7 5519.5 5522.7 5525.0 5526.7 4103.9 4211.2 5452.9 5499.5 5885.1 6001.1 6031.1 6046.2 6052.4 6058.2 5090.3 5263.0 5300.7 5304.2 6010.4 5072.3 5087.4 5097.2 5098.0 5373.1 12314.9 12396.2 12642.7 12670.4 13228.6 1949.7 2003.3 2047.8 2065.9 2124.2 8854.5 9072.7 9205.5 9561.9 9605.6 1541.0 1544.6 1607.0 1635.3 1672.0 55412.2 56017.7 56640.2 57437.4 57739.4 9823.3 10181.1 10366.9 10465.5 10512.9 13574.4 13645.0 13652.5 13659.1 13668.6 7449.3 7486.7 7524.0 7545.5 7583.3 7164.0 7174.9 7185.3 7225.3 7226.6 4435.5 4498.8 4517.7 4533.5 4540.4 1743.5 1779.0 1789.3 1791.6 1838.3 833.9 893.5 901.2 997.5 1069.6 16457.7 16939.0 17203.8 17300.2 17534.5 895.8 902.1 921.1 927.7 979.8 6097.6 6526.3 9506.7 9947.2 9979.8 609479.0 630671.0 635691.4 640185.0 646590.0 78688.6 81954.2 82915.0 83011.6 83931.0 519.4 525.0 526.0 526.8 527.5 10726.5 10864.4 10912.0 10931.3 10940.6 36056.0 36270.5 37289.6 37568.8 37593.2 46845.3 47577.8 48692.3 49035.0 50166.0 13807.9 14201.1 14342.9 14375.6 14583.9 16895.0 17315.7 17355.6 17584.3 18230.2 13901.9 14363.3 14383.9 14505.0 14952.8 14155.6 14406.9 14966.6 15670.0 15730.9 14553.3 14638.6 14673.8 15041.5 15204.8 14036.9 14230.3 14322.4 14335.9 14425.2 13542.9 13720.6 13974.5 14409.3 14568.6 11:33:03 INFO - PROCESS | 22956 | 11:33:03 INFO - PROCESS | 22956 | [#3] mootools.html Cycles:180 Average:5378.59 Median:5969.43 stddev:2830.30 (47.4%) stddev-sans-first:2821.76 11:33:03 INFO - PROCESS | 22956 | Values: 1315.8 1449.2 1465.3 1630.3 1835.5 7053.5 7708.2 7893.8 7914.1 7920.1 7756.7 7895.1 7936.8 7948.1 7953.7 1989.7 2002.6 2033.1 2246.0 2282.1 2284.6 2330.9 2331.9 2333.8 2333.8 2235.1 2257.5 2263.7 2277.0 2285.1 2238.0 2239.4 2259.7 2289.5 2305.3 2293.0 2296.1 2321.9 2323.3 2324.8 7841.4 7897.2 7900.4 7903.6 7913.1 4661.7 4742.4 4761.3 4762.1 4764.5 3139.9 3144.4 3185.1 3187.8 3237.1 990.6 1034.2 1039.2 1088.4 1109.2 11032.0 11038.7 11041.3 11045.7 11051.8 4245.8 4321.6 4346.3 4367.0 4369.2 9323.9 9341.2 9357.5 9370.0 9370.7 4779.4 4820.8 4821.3 4827.4 4831.8 4357.3 4375.2 4384.1 4393.9 4397.8 3329.5 3354.4 3611.2 3620.8 3660.7 1140.1 1162.3 1167.3 1192.2 1202.6 863.4 863.8 864.3 895.5 937.4 7138.2 7188.1 7219.1 7240.9 7347.3 1032.5 1044.9 1059.9 1071.0 1109.6 5447.8 5496.7 5510.1 5512.4 5513.1 8823.9 8914.0 9039.5 9321.1 9353.2 9254.3 9353.9 9357.6 9357.9 9361.3 7371.7 7476.9 7494.3 7568.1 7607.5 7027.5 7042.8 7049.6 7050.7 7053.3 8441.5 8505.1 8524.1 8600.5 8694.1 8660.8 8836.5 8849.2 9052.3 9078.0 6220.3 6374.6 6387.5 6390.1 6390.4 6490.9 6653.9 6942.5 7070.3 7084.8 6775.7 6809.1 6876.6 6954.8 6977.0 6464.5 6527.5 6612.2 6626.5 6724.7 6096.1 6124.2 6132.9 6138.0 6139.9 5717.2 5932.6 5981.4 5983.6 5987.4 5902.5 5930.4 5940.4 5941.0 5957.5 11:33:03 INFO - PROCESS | 22956 | 11:33:03 INFO - PROCESS | 22956 | [#4] prototype.html Cycles:180 Average:5265.42 Median:5950.08 stddev:1572.90 (26.4%) stddev-sans-first:1533.31 11:33:03 INFO - PROCESS | 22956 | Values: 343.1 349.5 350.5 354.9 355.3 5863.8 5931.4 5964.8 5989.5 5993.5 5602.6 5683.4 5730.2 5854.3 5870.3 4516.4 4550.0 4562.3 4566.9 4585.4 4557.2 4571.7 4577.4 4580.1 4580.2 4304.4 4396.5 4397.4 4461.3 4500.3 4477.3 4483.2 4492.4 4494.6 4497.1 4015.0 4026.3 4027.5 4030.1 4034.9 5602.6 5602.7 5603.5 5608.5 5614.6 5171.7 5293.8 5308.4 5317.3 5318.6 6123.8 6166.2 6171.5 6177.0 6177.8 4484.8 4488.2 4490.0 4494.7 4506.1 6289.5 6516.8 6518.0 6519.5 6540.9 4493.9 4525.3 4525.9 4529.2 4529.5 4570.7 4571.3 4588.1 4588.2 4593.0 5243.3 5247.6 5250.4 5254.9 5254.9 6067.8 6257.1 6268.2 6298.9 6310.6 1593.6 1614.7 1614.8 1616.1 1617.7 1063.9 1070.8 1081.9 1086.1 1100.0 5944.3 5955.9 5977.0 5979.9 5985.9 6476.6 6476.7 6478.6 6479.5 6481.2 5785.1 5850.6 5929.0 5980.4 6044.5 3498.0 3507.1 3517.9 3525.3 3528.5 6719.8 6745.6 6752.0 6755.0 6755.9 6568.3 6663.7 6670.9 6692.9 6695.5 6670.1 6673.5 6694.6 6734.2 6737.7 6457.8 6501.6 6502.5 6513.8 6519.2 6328.6 6437.6 6449.9 6457.8 6458.6 6737.1 6745.2 6751.4 6755.2 6757.9 4551.7 4556.6 4556.8 4557.0 4558.7 6357.7 6519.3 6520.0 6532.9 6534.5 6340.6 6352.1 6357.7 6362.2 6364.2 6273.7 6326.2 6340.4 6342.7 6345.3 5994.5 6178.0 6179.5 6223.2 6225.5 6292.0 6315.1 6372.4 6380.2 6393.2 6234.7 6238.3 6242.3 6246.4 6247.3 11:33:03 INFO - PROCESS | 22956 | 11:33:03 INFO - PROCESS | 22956 | [#5] yui.html Cycles:180 Average:13023.83 Median:27467.81 stddev:15576.39 (56.7%) stddev-sans-first:15592.49 11:33:03 INFO - PROCESS | 22956 | Values: 677.7 698.5 715.6 766.3 803.7 11992.8 12154.8 12163.1 12182.9 12211.4 11199.4 11263.4 11272.0 11280.0 11287.0 682.1 682.7 807.6 814.7 831.7 827.0 828.1 834.2 835.2 835.6 866.7 874.7 875.2 875.5 875.8 712.3 714.9 836.0 864.3 866.0 633.9 634.8 638.6 639.0 639.6 11395.5 11396.4 11467.4 11474.7 11485.9 10415.8 10491.3 10518.2 10912.6 11323.5 9541.3 9707.6 9738.4 9767.3 9908.9 3478.5 3517.7 3540.8 3543.5 3609.8 46566.5 46640.3 46667.8 46757.8 46762.8 9095.9 9135.1 9190.5 9291.4 9389.3 18575.6 18591.2 18602.9 18627.9 18649.0 6934.5 7170.2 7281.9 7302.8 7360.6 3532.5 3565.8 3575.8 3608.6 3629.1 2989.6 3005.1 3006.5 3010.5 3030.5 546.3 547.9 556.7 568.8 582.5 504.8 581.9 595.8 603.7 617.8 7377.5 7712.6 7988.0 8091.5 8413.6 494.5 537.1 543.9 571.1 631.8 3421.4 3512.6 3693.3 3722.8 3754.9 53685.0 54163.0 54213.2 54391.7 54526.7 49754.0 50796.5 50911.5 50918.7 51354.0 45061.1 45662.1 46627.3 47321.5 49919.5 7517.6 7519.0 7608.8 7723.9 7857.2 33388.5 33935.8 34160.5 34172.8 34182.5 40326.2 40711.0 41179.8 44921.1 45011.8 9692.2 9717.8 9881.0 9893.6 10191.4 10958.6 10986.7 11042.0 11551.9 11553.4 9831.0 10004.5 10112.5 10280.7 10292.7 9336.5 9544.8 9743.8 9997.7 9997.8 9776.0 10136.3 10304.4 10317.7 10641.1 8500.3 8574.2 8633.8 8634.9 8798.3 7750.4 8116.6 8228.5 8296.6 8296.7 11:33:03 INFO - PROCESS | 22956 | -------- Summary: end -------- 11:33:03 INFO - PROCESS | 22956 | 11:33:03 INFO - TEST-INFO | 22956: exit 0 11:33:03 INFO - TEST-OK | dromaeo_css | took 1112681ms 11:33:03 INFO - TEST-START | kraken 11:33:03 INFO - operating with platform_type : linux_ 11:33:03 INFO - Initialising browser for kraken test... 11:33:03 INFO - TEST-INFO | started process 23155 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCJMIiR/profile http://localhost:49092/getInfo.html) 11:33:08 INFO - PROCESS | 23155 | __metrics Screen width/height:1600/1200 11:33:08 INFO - PROCESS | 23155 | colorDepth:24 11:33:08 INFO - PROCESS | 23155 | Browser inner width/height: 1024/697 11:33:08 INFO - PROCESS | 23155 | __metrics 11:33:08 INFO - PROCESS | 23155 | 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:33:08 INFO - PROCESS | 23155 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:33:08 INFO - TEST-INFO | 23155: exit 0 11:33:08 INFO - Browser initialized. 11:33:08 INFO - Running cycle 1/1 for kraken test... 11:33:08 INFO - TEST-INFO | started process 23234 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCJMIiR/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:33:20 INFO - PROCESS | 23234 | RSS: Main: 150134784 11:33:20 INFO - PROCESS | 23234 | 11:33:23 INFO - PROCESS | 23234 | Cycle 1(1): loaded http://localhost:49092/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49092/tests/kraken/driver.html?testName=audio-beat-detection) 11:33:23 INFO - PROCESS | 23234 | RSS: Main: 186413056 11:33:23 INFO - PROCESS | 23234 | 11:33:26 INFO - PROCESS | 23234 | Cycle 1(1): loaded http://localhost:49092/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49092/tests/kraken/driver.html?testName=audio-dft) 11:33:26 INFO - PROCESS | 23234 | RSS: Main: 175575040 11:33:26 INFO - PROCESS | 23234 | 11:33:29 INFO - PROCESS | 23234 | Cycle 1(1): loaded http://localhost:49092/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49092/tests/kraken/driver.html?testName=audio-fft) 11:33:30 INFO - PROCESS | 23234 | RSS: Main: 159531008 11:33:30 INFO - PROCESS | 23234 | 11:33:32 INFO - PROCESS | 23234 | Cycle 1(1): loaded http://localhost:49092/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49092/tests/kraken/driver.html?testName=audio-oscillator) 11:33:32 INFO - PROCESS | 23234 | RSS: Main: 162320384 11:33:32 INFO - PROCESS | 23234 | 11:33:35 INFO - PROCESS | 23234 | Cycle 1(1): loaded http://localhost:49092/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49092/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:33:35 INFO - PROCESS | 23234 | RSS: Main: 163565568 11:33:35 INFO - PROCESS | 23234 | 11:33:38 INFO - PROCESS | 23234 | Cycle 1(1): loaded http://localhost:49092/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49092/tests/kraken/driver.html?testName=imaging-darkroom) 11:33:39 INFO - PROCESS | 23234 | RSS: Main: 164937728 11:33:39 INFO - PROCESS | 23234 | 11:33:42 INFO - PROCESS | 23234 | Cycle 1(1): loaded http://localhost:49092/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49092/tests/kraken/driver.html?testName=imaging-desaturate) 11:33:43 INFO - PROCESS | 23234 | RSS: Main: 164810752 11:33:43 INFO - PROCESS | 23234 | 11:33:45 INFO - PROCESS | 23234 | Cycle 1(1): loaded http://localhost:49092/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49092/tests/kraken/driver.html?testName=json-parse-financial) 11:33:46 INFO - PROCESS | 23234 | RSS: Main: 164646912 11:33:46 INFO - PROCESS | 23234 | 11:33:48 INFO - PROCESS | 23234 | Cycle 1(1): loaded http://localhost:49092/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49092/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:33:48 INFO - PROCESS | 23234 | RSS: Main: 176156672 11:33:48 INFO - PROCESS | 23234 | 11:33:50 INFO - PROCESS | 23234 | Cycle 1(1): loaded http://localhost:49092/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49092/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:33:50 INFO - PROCESS | 23234 | RSS: Main: 175722496 11:33:50 INFO - PROCESS | 23234 | 11:33:53 INFO - PROCESS | 23234 | Cycle 1(1): loaded http://localhost:49092/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49092/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:33:53 INFO - PROCESS | 23234 | RSS: Main: 188428288 11:33:53 INFO - PROCESS | 23234 | 11:33:55 INFO - PROCESS | 23234 | Cycle 1(1): loaded http://localhost:49092/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49092/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:33:56 INFO - PROCESS | 23234 | RSS: Main: 192589824 11:33:56 INFO - PROCESS | 23234 | 11:33:59 INFO - PROCESS | 23234 | Cycle 1(1): loaded http://localhost:49092/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49092/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:33:59 INFO - PROCESS | 23234 | RSS: Main: 192315392 11:33:59 INFO - PROCESS | 23234 | 11:34:01 INFO - PROCESS | 23234 | Cycle 1(1): loaded http://localhost:49092/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49092/tests/kraken/driver.html?testName=ai-astar) 11:34:01 INFO - PROCESS | 23234 | RSS: Main: 249524224 11:34:01 INFO - PROCESS | 23234 | 11:34:01 INFO - PROCESS | 23234 | __start_tp_report 11:34:01 INFO - PROCESS | 23234 | _x_x_mozilla_page_load 11:34:01 INFO - PROCESS | 23234 | _x_x_mozilla_page_load_details 11:34:01 INFO - PROCESS | 23234 | |i|pagename|runs| 11:34:01 INFO - PROCESS | 23234 | |0;ai-astar;109;110;104;110;109;110;101;109;109;108 11:34:01 INFO - PROCESS | 23234 | |1;audio-beat-detection;152;124;150;161;131;150;150;126;172;129 11:34:01 INFO - PROCESS | 23234 | |2;audio-dft;162;161;162;161;161;161;159;161;161;160 11:34:01 INFO - PROCESS | 23234 | |3;audio-fft;72;73;87;99;71;74;71;112;101;71 11:34:01 INFO - PROCESS | 23234 | |4;audio-oscillator;96;97;137;96;97;97;142;96;96;141 11:34:01 INFO - PROCESS | 23234 | |5;imaging-gaussian-blur;109;109;109;109;110;109;109;109;109;111 11:34:01 INFO - PROCESS | 23234 | |6;imaging-darkroom;147;146;146;146;147;147;145;146;146;146 11:34:01 INFO - PROCESS | 23234 | |7;imaging-desaturate;96;96;96;96;95;96;95;95;96;96 11:34:01 INFO - PROCESS | 23234 | |8;json-parse-financial;57;57;57;56;56;56;56;56;56;54 11:34:01 INFO - PROCESS | 23234 | |9;json-stringify-tinderbox;67;67;67;67;67;67;68;68;67;67 11:34:01 INFO - PROCESS | 23234 | |10;stanford-crypto-aes;84;84;86;87;86;85;87;85;87;90 11:34:01 INFO - PROCESS | 23234 | |11;stanford-crypto-ccm;121;117;131;116;115;116;123;131;117;119 11:34:01 INFO - PROCESS | 23234 | |12;stanford-crypto-pbkdf2;153;144;142;150;151;142;149;152;150;141 11:34:01 INFO - PROCESS | 23234 | |13;stanford-crypto-sha256-iterative;68;70;70;70;68;68;69;70;67;67 11:34:01 INFO - PROCESS | 23234 | __end_tp_report 11:34:01 INFO - PROCESS | 23234 | __start_cc_report 11:34:01 INFO - PROCESS | 23234 | _x_x_mozilla_cycle_collect,918 11:34:01 INFO - PROCESS | 23234 | __end_cc_report 11:34:01 INFO - PROCESS | 23234 | __startTimestamp1451936041645__endTimestamp 11:34:01 INFO - PROCESS | 23234 | 11:34:01 INFO - PROCESS | 23234 | ------- Summary: start ------- 11:34:01 INFO - PROCESS | 23234 | Number of tests: 14 11:34:01 INFO - PROCESS | 23234 | 11:34:01 INFO - PROCESS | 23234 | [#0] ai-astar Cycles:10 Average:107.90 Median:109.00 stddev:3.00 (2.8%) stddev-sans-first:3.15 11:34:01 INFO - PROCESS | 23234 | Values: 109.0 110.0 104.0 110.0 109.0 110.0 101.0 109.0 109.0 108.0 11:34:01 INFO - PROCESS | 23234 | 11:34:01 INFO - PROCESS | 23234 | [#1] audio-beat-detection Cycles:10 Average:144.50 Median:150.00 stddev:16.19 (10.8%) stddev-sans-first:16.95 11:34:01 INFO - PROCESS | 23234 | Values: 152.0 124.0 150.0 161.0 131.0 150.0 150.0 126.0 172.0 129.0 11:34:01 INFO - PROCESS | 23234 | 11:34:01 INFO - PROCESS | 23234 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.88 (0.5%) stddev-sans-first:0.83 11:34:01 INFO - PROCESS | 23234 | Values: 162.0 161.0 162.0 161.0 161.0 161.0 159.0 161.0 161.0 160.0 11:34:01 INFO - PROCESS | 23234 | 11:34:01 INFO - PROCESS | 23234 | [#3] audio-fft Cycles:10 Average:83.10 Median:72.50 stddev:15.53 (21.4%) stddev-sans-first:15.95 11:34:01 INFO - PROCESS | 23234 | Values: 72.0 73.0 87.0 99.0 71.0 74.0 71.0 112.0 101.0 71.0 11:34:01 INFO - PROCESS | 23234 | 11:34:01 INFO - PROCESS | 23234 | [#4] audio-oscillator Cycles:10 Average:109.50 Median:96.00 stddev:21.09 (22.0%) stddev-sans-first:21.79 11:34:01 INFO - PROCESS | 23234 | Values: 96.0 97.0 137.0 96.0 97.0 97.0 142.0 96.0 96.0 141.0 11:34:01 INFO - PROCESS | 23234 | 11:34:01 INFO - PROCESS | 23234 | [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 11:34:01 INFO - PROCESS | 23234 | Values: 109.0 109.0 109.0 109.0 110.0 109.0 109.0 109.0 109.0 111.0 11:34:01 INFO - PROCESS | 23234 | 11:34:01 INFO - PROCESS | 23234 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 11:34:01 INFO - PROCESS | 23234 | Values: 147.0 146.0 146.0 146.0 147.0 147.0 145.0 146.0 146.0 146.0 11:34:01 INFO - PROCESS | 23234 | 11:34:01 INFO - PROCESS | 23234 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 11:34:01 INFO - PROCESS | 23234 | Values: 96.0 96.0 96.0 96.0 95.0 96.0 95.0 95.0 96.0 96.0 11:34:01 INFO - PROCESS | 23234 | 11:34:01 INFO - PROCESS | 23234 | [#8] json-parse-financial Cycles:10 Average:56.10 Median:56.00 stddev:0.88 (1.6%) stddev-sans-first:0.87 11:34:01 INFO - PROCESS | 23234 | Values: 57.0 57.0 57.0 56.0 56.0 56.0 56.0 56.0 56.0 54.0 11:34:01 INFO - PROCESS | 23234 | 11:34:01 INFO - PROCESS | 23234 | [#9] json-stringify-tinderbox Cycles:10 Average:67.20 Median:67.00 stddev:0.42 (0.6%) stddev-sans-first:0.44 11:34:01 INFO - PROCESS | 23234 | Values: 67.0 67.0 67.0 67.0 67.0 67.0 68.0 68.0 67.0 67.0 11:34:01 INFO - PROCESS | 23234 | 11:34:01 INFO - PROCESS | 23234 | [#10] stanford-crypto-aes Cycles:10 Average:86.10 Median:86.50 stddev:1.79 (2.1%) stddev-sans-first:1.73 11:34:01 INFO - PROCESS | 23234 | Values: 84.0 84.0 86.0 87.0 86.0 85.0 87.0 85.0 87.0 90.0 11:34:01 INFO - PROCESS | 23234 | 11:34:01 INFO - PROCESS | 23234 | [#11] stanford-crypto-ccm Cycles:10 Average:120.60 Median:120.00 stddev:6.00 (5.0%) stddev-sans-first:6.37 11:34:01 INFO - PROCESS | 23234 | Values: 121.0 117.0 131.0 116.0 115.0 116.0 123.0 131.0 117.0 119.0 11:34:01 INFO - PROCESS | 23234 | 11:34:01 INFO - PROCESS | 23234 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.40 Median:150.00 stddev:4.62 (3.1%) stddev-sans-first:4.44 11:34:01 INFO - PROCESS | 23234 | Values: 153.0 144.0 142.0 150.0 151.0 142.0 149.0 152.0 150.0 141.0 11:34:01 INFO - PROCESS | 23234 | 11:34:01 INFO - PROCESS | 23234 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:69.50 stddev:1.25 (1.8%) stddev-sans-first:1.30 11:34:01 INFO - PROCESS | 23234 | Values: 68.0 70.0 70.0 70.0 68.0 68.0 69.0 70.0 67.0 67.0 11:34:01 INFO - PROCESS | 23234 | -------- Summary: end -------- 11:34:01 INFO - PROCESS | 23234 | 11:34:02 INFO - TEST-INFO | 23234: exit 0 11:34:02 INFO - TEST-OK | kraken | took 58605ms 11:34:02 INFO - TEST-START | v8_7 11:34:02 INFO - operating with platform_type : linux_ 11:34:02 INFO - Initialising browser for v8_7 test... 11:34:02 INFO - TEST-INFO | started process 23484 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9Dc2IE/profile http://localhost:49092/getInfo.html) 11:34:06 INFO - PROCESS | 23484 | __metrics Screen width/height:1600/1200 11:34:06 INFO - PROCESS | 23484 | colorDepth:24 11:34:06 INFO - PROCESS | 23484 | Browser inner width/height: 1024/697 11:34:06 INFO - PROCESS | 23484 | __metrics 11:34:06 INFO - PROCESS | 23484 | 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:34:06 INFO - PROCESS | 23484 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:34:07 INFO - TEST-INFO | 23484: exit 0 11:34:07 INFO - Browser initialized. 11:34:07 INFO - Running cycle 1/1 for v8_7 test... 11:34:07 INFO - TEST-INFO | started process 23569 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9Dc2IE/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:34:19 INFO - PROCESS | 23569 | RSS: Main: 150179840 11:34:19 INFO - PROCESS | 23569 | 11:34:40 INFO - PROCESS | 23569 | Cycle 1(1): loaded http://localhost:49092/tests/v8_7/run.html (next: http://localhost:49092/tests/v8_7/run.html) 11:34:40 INFO - PROCESS | 23569 | RSS: Main: 579514368 11:34:40 INFO - PROCESS | 23569 | 11:34:40 INFO - PROCESS | 23569 | __start_tp_report 11:34:40 INFO - PROCESS | 23569 | _x_x_mozilla_page_load 11:34:40 INFO - PROCESS | 23569 | _x_x_mozilla_page_load_details 11:34:40 INFO - PROCESS | 23569 | |i|pagename|runs| 11:34:40 INFO - PROCESS | 23569 | |0;Richards;168.12373907195695 11:34:40 INFO - PROCESS | 23569 | |1;DeltaBlue;191.46084625694044 11:34:40 INFO - PROCESS | 23569 | |2;Encrypt;282.0078962210942 11:34:40 INFO - PROCESS | 23569 | |3;Decrypt;5159.79381443299 11:34:40 INFO - PROCESS | 23569 | |4;RayTrace;1098.901098901099 11:34:40 INFO - PROCESS | 23569 | |5;Earley;785.5459544383347 11:34:40 INFO - PROCESS | 23569 | |6;Boyer;12329.268292682927 11:34:40 INFO - PROCESS | 23569 | |7;RegExp;25974.358974358973 11:34:40 INFO - PROCESS | 23569 | |8;Splay;628.5355122564425 11:34:40 INFO - PROCESS | 23569 | |9;NavierStokes;4826.923076923077 11:34:40 INFO - PROCESS | 23569 | __end_tp_report 11:34:40 INFO - PROCESS | 23569 | __startTimestamp1451936080947__endTimestamp 11:34:40 INFO - PROCESS | 23569 | 11:34:40 INFO - PROCESS | 23569 | ------- Summary: start ------- 11:34:40 INFO - PROCESS | 23569 | Number of tests: 10 11:34:40 INFO - PROCESS | 23569 | 11:34:40 INFO - PROCESS | 23569 | [#0] Richards Cycles:1 Average:168.12 Median:168.12 stddev:0.00 (0.0%) 11:34:40 INFO - PROCESS | 23569 | Values: 168.1 11:34:40 INFO - PROCESS | 23569 | 11:34:40 INFO - PROCESS | 23569 | [#1] DeltaBlue Cycles:1 Average:191.46 Median:191.46 stddev:0.00 (0.0%) 11:34:40 INFO - PROCESS | 23569 | Values: 191.5 11:34:40 INFO - PROCESS | 23569 | 11:34:40 INFO - PROCESS | 23569 | [#2] Encrypt Cycles:1 Average:282.01 Median:282.01 stddev:0.00 (0.0%) 11:34:40 INFO - PROCESS | 23569 | Values: 282.0 11:34:40 INFO - PROCESS | 23569 | 11:34:40 INFO - PROCESS | 23569 | [#3] Decrypt Cycles:1 Average:5159.79 Median:5159.79 stddev:0.00 (0.0%) 11:34:40 INFO - PROCESS | 23569 | Values: 5159.8 11:34:40 INFO - PROCESS | 23569 | 11:34:40 INFO - PROCESS | 23569 | [#4] RayTrace Cycles:1 Average:1098.90 Median:1098.90 stddev:0.00 (0.0%) 11:34:40 INFO - PROCESS | 23569 | Values: 1098.9 11:34:40 INFO - PROCESS | 23569 | 11:34:40 INFO - PROCESS | 23569 | [#5] Earley Cycles:1 Average:785.55 Median:785.55 stddev:0.00 (0.0%) 11:34:40 INFO - PROCESS | 23569 | Values: 785.5 11:34:40 INFO - PROCESS | 23569 | 11:34:40 INFO - PROCESS | 23569 | [#6] Boyer Cycles:1 Average:12329.27 Median:12329.27 stddev:0.00 (0.0%) 11:34:40 INFO - PROCESS | 23569 | Values: 12329.3 11:34:40 INFO - PROCESS | 23569 | 11:34:40 INFO - PROCESS | 23569 | [#7] RegExp Cycles:1 Average:25974.36 Median:25974.36 stddev:0.00 (0.0%) 11:34:40 INFO - PROCESS | 23569 | Values: 25974.4 11:34:40 INFO - PROCESS | 23569 | 11:34:40 INFO - PROCESS | 23569 | [#8] Splay Cycles:1 Average:628.54 Median:628.54 stddev:0.00 (0.0%) 11:34:40 INFO - PROCESS | 23569 | Values: 628.5 11:34:40 INFO - PROCESS | 23569 | 11:34:40 INFO - PROCESS | 23569 | [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 11:34:40 INFO - PROCESS | 23569 | Values: 4826.9 11:34:40 INFO - PROCESS | 23569 | -------- Summary: end -------- 11:34:40 INFO - PROCESS | 23569 | 11:34:41 INFO - TEST-INFO | 23569: exit 0 11:34:41 INFO - TEST-OK | v8_7 | took 39157ms 11:34:41 INFO - SUITE-END | took 1210s 11:34:41 INFO - Completed test suite (00:20:10) 11:34:41 INFO - Working with test: dromaeo_css 11:34:41 INFO - Generating results file: dromaeo_css 11:34:41 INFO - Working with test: kraken 11:34:41 INFO - Generating results file: kraken 11:34:41 INFO - javascript benchmark 11:34:41 INFO - Working with test: v8_7 11:34:41 INFO - Generating results file: v8_7 11:34:41 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:34:42 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 11:34:42 INFO - process_Request line: dromaeo_css 6803.80 graph.html#tests=[[72,64,35]] 11:34:42 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:34:42 INFO - process_Request line: kraken 1503.20 graph.html#tests=[[232,64,35]] 11:34:42 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:34:42 INFO - process_Request line: v8_7 20895.59 graph.html#tests=[[230,64,35]] 11:34:42 INFO - RETURN: dromaeo_css: 6803.80 11:34:42 INFO - RETURN: kraken: 1503.20 11:34:42 INFO - RETURN: v8_7: 20895.59 11:34:42 INFO - javascript benchmark 11:34:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3056.5567992641068, 3112.05082449853, 3161.367726454708, 3161.8260995645232, 3184.697453741895, 5175.120229560975, 5251.054810134175, 5255.421903590602, 5273.050850846846, 5310.4158542560335, 5250.501202385777, 5275.736213189335, 5304.973475132629, 5316.627836051478, 5325.334333208349, 4630.421197350332, 4769.070031343889, 4776.235802271629, 4833.0, 4911.8772030699165, 4711.246200607903, 4862.17343051682, 4878.048780487807, 4916.3608730864935, 4938.604911607081, 4804.783784729696, 4805.399325084364, 4913.729744864031, 4936.827211047596, 4940.061388336205, 4808.711477311373, 4809.182438985381, 4826.251930950708, 4839.854804355875, 4846.709197448165, 4745.572898439123, 4775.689580177312, 4786.066716990188, 4825.420949486049, 4864.173090574611, 4998.150314446553, 5104.3109180260935, 5115.872103197413, 5200.921986170172, 5231.163013917793, 5697.658140511541, 5702.201691763156, 5704.629199102045, 5709.571782116358, 5712.742926568273, 5557.444255574451, 5701.116326969326, 5754.108113242454, 5758.193852860602, 5759.539236861041, 5225.242339860737, 5279.102552566034, 5292.867678308035, 5334.199870019451, 5381.031414345416, 5781.942180578225, 5796.449337312949, 5801.3908539602735, 5814.186013958049, 5823.708814559255, 5433.918491222635, 5554.055810512223, 5565.66606003633, 5575.0, 5582.7766889323975, 5554.805581804618, 5610.270664813548, 5634.126710359901, 5725.227094342211, 5731.0, 5625.0, 5635.718214089361, 5643.463870932255, 5644.463775941279, 5647.519960803378, 5549.556035517149, 5649.576281778883, 5653.886922261532, 5657.773689052392, 5658.34928983164, 4357.2592659248, 4397.560243975641, 4410.0738844842945, 4416.779161041999, 4434.5343738907595, 3937.4881265435884, 3951.8419263229725, 3956.604339566078, 3989.4215338776294, 3991.560928297885, 5344.225087362311, 5345.38528069277, 5350.170723537858, 5350.197470379474, 5358.490943360374, 5587.469190426903, 5596.748146333425, 5656.208130861683, 5692.0608099663095, 5722.685252311163, 5228.058949389147, 5250.002499525154, 5250.868728281747, 5261.921071183859, 5300.496452836975, 4838.274258861128, 4840.491748366371, 4844.176489996709, 4847.854564363075, 4878.536539028786, 5742.425757424307, 5783.508401785895, 5829.854253643693, 5832.096025116114, 5848.181254624356, 5650.463205995424, 5683.175939488834, 5692.943070569241, 5705.800296989585, 5734.168545560954, 5885.087811389241, 5892.469677729025, 5893.2044174035955, 5893.734781934909, 5900.468957793819, 5446.237526746338, 5564.721763911869, 5583.972080139573, 5628.577856660685, 5681.971590142023, 5642.71786410686, 5656.6888821115235, 5682.9147562785765, 5688.63023903445, 5689.0, 5530.0, 5568.053430916673, 5589.105743081088, 5596.888062238651, 5599.524040456607, 5457.61796674229, 5551.0, 5567.220589117608, 5577.27495425592, 5662.235598194356, 5504.614676972574, 5517.089680202722, 5525.281713377235, 5526.253955715927, 5526.336839579276, 5563.332400112013, 5588.161775733673, 5602.271704678529, 5610.859728506657, 5664.122061080539, 5361.410244873139, 5469.206964989975, 5473.261109750292, 5477.726113694379, 5493.862653433696], "unit": "score", "name": "dojo.html", "value": 5228.832013264779}, {"lowerIsBetter": false, "replicates": [547.2857920413861, 556.0325034440076, 560.8457674139613, 570.4837122404224, 575.3556017260669, 27909.302267443298, 28663.283417914536, 28729.138125856232, 36108.0, 36835.81582092092, 39268.41097383542, 39392.409113863316, 39526.8023659882, 39603.80198099012, 39675.603243967555, 8446.239838414542, 8615.913840861574, 8631.568421578928, 8633.611487483047, 8635.309175265964, 7538.623068846563, 7692.653830577638, 9774.90225097747, 10002.34984725994, 10004.649837255698, 9811.166050885684, 9967.501624918725, 9972.10251077403, 9978.800423991515, 9981.50092495376, 7612.7716168515035, 7789.9221007789765, 9822.312438129335, 9934.45360505172, 9943.552540135675, 9916.157126644244, 10159.187265018782, 10164.0344167304, 10166.745831354201, 10167.89832101677, 36724.0, 37173.442398364044, 37192.0, 37210.0, 37217.81391093027, 2906.8837246510116, 2941.691122432135, 2971.509700899349, 3066.693330666938, 3635.527381440396, 28651.426971460663, 29999.100026999226, 30039.249018774488, 30088.398232035237, 30367.696323036707, 3758.1544152565725, 3841.1707181470147, 3845.4616353710503, 3906.257811015898, 4102.712810103294, 263202.0, 264432.0, 264510.0, 264920.0, 265092.0, 51044.23433648498, 51950.76590809127, 57677.42322576804, 58280.12579811221, 58975.0, 53032.469675303524, 53041.0, 53201.46798531965, 53314.20028699573, 53328.73335633297, 14817.70364592702, 14888.776668349983, 14920.552383428514, 14981.850181498046, 15026.098434093989, 11204.327740335606, 11251.212415130862, 11292.15308851823, 11314.717132071764, 11393.202475826778, 18879.716804247946, 18904.432867013737, 18996.715049274273, 19056.904715476336, 19075.809241907682, 7402.596753808025, 7634.427417943676, 7702.807429814299, 7709.653065612061, 7794.0, 901.6078006067381, 961.1637875048752, 964.9324547281623, 1029.325791606499, 1136.670365593985, 27969.72030279712, 28008.71991280061, 28884.27789305284, 28909.85545072261, 29025.85487072551, 1025.5231317437429, 1110.8000559899297, 1135.432283858071, 1170.1224081938547, 1189.5598628507335, 14817.925910370379, 14912.47806326795, 14940.32768525419, 15015.699686006219, 15073.849261507245, 313338.0, 315987.0, 317101.0, 318203.0, 319359.0, 51870.48129518732, 52226.73886630542, 52243.21635175475, 52248.0, 52325.2151217732, 1296.4230917241737, 1300.479808076758, 1316.3352506984104, 1318.2881244128255, 1328.249539010456, 22566.548669026855, 28442.573361399183, 28761.856190718914, 28807.855960720062, 29204.0, 45151.54848451474, 45674.0, 45752.771236143606, 45756.54243457656, 45761.08477830491, 236939.0, 238646.0, 238752.0, 239055.0, 239360.0, 27387.726122739314, 27800.0, 29316.7068329314, 31179.376412472076, 31760.523592146597, 36628.0842978917, 36929.815350923076, 37508.624913750515, 37652.81173594115, 37855.81072094622, 31591.88813704981, 32217.35565288634, 32307.35385292328, 32665.34669306648, 33971.83014084914, 28422.28944276327, 33229.66770332266, 33421.33157336791, 34320.48519272263, 36553.45169822402, 31320.21699457532, 31956.36087278288, 32047.679523205403, 32141.196470088435, 32148.678513215506, 28212.576811347437, 30949.535756963214, 31077.22306942254, 31255.84372078125, 31649.525257121622, 24067.398315042265, 24106.39734006664, 24136.396590084685, 24152.396190095387, 24408.0], "unit": "score", "name": "ext.html", "value": 17835.10304819057}, {"lowerIsBetter": false, "replicates": [365.65993625927894, 368.2689860626656, 368.4767629965449, 370.3870094992788, 370.8887333799861, 13569.932150339258, 13644.590662280123, 16429.671406571877, 16889.32442702292, 17514.47456576303, 15449.845501544982, 15623.21883905803, 15903.363865445397, 15949.920250398733, 16016.75974860378, 5368.731563421833, 5519.530839878616, 5522.66863988162, 5524.972375138119, 5526.723663816813, 4103.897402564945, 4211.1998720243055, 5452.863678408032, 5499.477549632778, 5885.117232415129, 6001.129836173752, 6031.1254868044325, 6046.1837651917085, 6052.394760523956, 6058.182145410379, 5090.33825602673, 5262.973685131569, 5300.708461034642, 5304.230886521472, 6010.36891126432, 5072.340595722532, 5087.414947281073, 5097.23541468779, 5097.974510127463, 5373.1402975524115, 12314.876851231462, 12396.194247373982, 12642.683932901751, 12670.429830657642, 13228.603141905758, 1949.717290992798, 2003.278819624934, 2047.7747447780732, 2065.9380218593465, 2124.192806733447, 8854.513001784899, 9072.682456114071, 9205.539723013822, 9561.904380956172, 9605.607186957852, 1540.9691806163814, 1544.6087786259516, 1606.9517914462585, 1635.3049953769719, 1672.0385778177597, 55412.16881746777, 56017.71991140059, 56640.150397744066, 57437.42562574363, 57739.42260577424, 9823.312368134304, 10181.134603558632, 10366.948165259277, 10465.47672616366, 10512.947435262928, 13574.389152488162, 13645.044846860625, 13652.522161724492, 13659.112157709716, 13668.589942301747, 7449.292317229854, 7486.700531978769, 7524.0, 7545.50954187987, 7583.317501424898, 7163.964180179066, 7174.852023676187, 7185.281471852877, 7225.2774722528375, 7226.602536860523, 4435.534268901783, 4498.797554110073, 4517.706349087299, 4533.455985281721, 4540.364348991144, 1743.4508129939281, 1778.9644207115784, 1789.2664007757016, 1791.5968906996081, 1838.2738818167018, 833.8749187621784, 893.5398269891011, 901.2159421303377, 997.486294558303, 1069.5882085397022, 16457.670846583, 16939.0, 17203.82796172047, 17300.22149003298, 17534.473965781046, 895.8253140637513, 902.0708670069838, 921.0881227584777, 927.7170463008847, 979.8383266760904, 6097.5731698780655, 6526.314736952647, 9506.667266645634, 9947.154491868272, 9979.800403992025, 609479.0, 630671.0, 635691.3938872762, 640185.0, 646590.0, 78688.60655696684, 81954.18045819465, 82915.0, 83011.5849420749, 83931.0, 519.3559985617807, 525.0391783037034, 526.0137242669994, 526.7892842862885, 527.4751622135999, 10726.51730672106, 10864.402457864893, 10912.0, 10931.344119352865, 10940.617078402218, 36056.0, 36270.4559431614, 37289.62710372861, 37568.81215593904, 37593.2481350366, 46845.2973205409, 47577.76211118922, 48692.26961595508, 49035.0, 50166.0, 13807.930960345135, 14201.147931124166, 14342.856571434151, 14375.640608984859, 14583.85416145825, 16895.0, 17315.7402638958, 17355.56611084733, 17584.296628135242, 18230.17964191641, 13901.930490347484, 14363.281835908372, 14383.856161438252, 14505.0, 14952.775708364166, 14155.64610884736, 14406.85593144097, 14966.625834354229, 15670.0, 15730.9213453932, 14553.27233638335, 14638.634034149232, 14673.779893301395, 15041.473548425753, 15204.771928421304, 14036.929815350857, 14230.288485575473, 14322.355494002586, 14335.85664143387, 14425.206613635932, 13542.864571354161, 13720.588382348546, 13974.510892118727, 14409.279536023367, 14568.635784105481], "unit": "score", "name": "jquery.html", "value": 8672.817576326455}, {"lowerIsBetter": false, "replicates": [1315.8223639808634, 1449.1667291307497, 1465.282011814211, 1630.339712416471, 1835.5044138082717, 7053.541519801216, 7708.1906399827985, 7893.763187104389, 7914.1294457609765, 7920.089189743181, 7756.689732410697, 7895.0920644125945, 7936.76189714308, 7948.085970113439, 7953.72161974331, 1989.7413336266266, 2002.5594369238745, 2033.085111699741, 2245.955080898381, 2282.1213832674457, 2284.6230371988604, 2330.8951097200666, 2331.94170145746, 2333.7549557296493, 2333.7782910623464, 2235.117128734149, 2257.480779420734, 2263.6830843681814, 2277.0436416705024, 2285.1430713482446, 2237.9776202238013, 2239.361781892161, 2259.6610508423705, 2289.461976435536, 2305.250793492105, 2293.048384920256, 2296.1159953417887, 2321.9071237150492, 2323.3494621506006, 2324.825638077151, 7841.411894107965, 7897.2497612727275, 7900.367970562341, 7903.644336004893, 7913.050433947906, 4661.650376221797, 4742.430908290993, 4761.333413322138, 4762.071396077767, 4764.452088009889, 3139.9372012559847, 3144.4025635129483, 3185.140012196717, 3187.792793468417, 3237.14215732831, 990.6334656177261, 1034.2088302448633, 1039.225776796284, 1088.3687461272443, 1109.1958330210614, 11032.0, 11038.724031899186, 11041.33751974876, 11045.723856903642, 11051.778964420666, 4245.787710614457, 4321.632661223831, 4346.326319420495, 4367.039251364695, 4369.191699535596, 9323.90676093244, 9341.159295663423, 9357.485338306322, 9370.0, 9370.718878433658, 4779.378680771547, 4820.831270905502, 4821.349117869113, 4827.372441582642, 4831.830885918976, 4357.302831546937, 4375.234333991539, 4384.12317536494, 4393.912121757547, 4397.780110994501, 3329.5338652588657, 3354.3794398036443, 3611.1513794258326, 3620.7646502977223, 3660.7071434285194, 1140.133498541098, 1162.3084264862393, 1167.3171194850938, 1192.1595275331044, 1202.6271855724578, 863.369740089738, 863.8099618084011, 864.3085531574715, 895.4940458640847, 937.386012162035, 7138.179109402485, 7188.101487314086, 7219.133703955559, 7240.855182896313, 7347.302006309392, 1032.4785983078498, 1044.9268551201494, 1059.9046085852156, 1070.983935240972, 1109.6005438042298, 5447.836564903059, 5496.697681627549, 5510.118381059011, 5512.4211957744665, 5513.145462453326, 8823.867641985375, 8913.955430222808, 9039.457632541937, 9321.06789321076, 9353.204977576846, 9254.259659227246, 9353.859692104625, 9357.578908949114, 9357.859632105525, 9361.251099911991, 7371.741989030358, 7476.887846682304, 7494.288042635941, 7568.053993250844, 7607.467477276648, 7027.4729395294535, 7042.7887163385185, 7049.612271325126, 7050.717971281091, 7053.294670533111, 8441.451305665112, 8505.149485051445, 8524.062353141273, 8600.483970961763, 8694.130586941255, 8660.78348041304, 8836.513991730259, 8849.20357167858, 9052.275817934682, 9077.954610226907, 6220.253569571681, 6374.649394283173, 6387.489000880011, 6390.073439351361, 6390.392912673288, 6490.935090649033, 6653.933460665525, 6942.479314051568, 7070.292970702889, 7084.752033678797, 6775.695093720696, 6809.148856392951, 6876.621785801829, 6954.756583519553, 6976.965115174595, 6464.450521705708, 6527.51043671717, 6612.239592446737, 6626.469882409492, 6724.697388617426, 6096.146539484387, 6124.203853499017, 6132.938670613236, 6137.96931015342, 6139.877202456015, 5717.1995920570325, 5932.5550583705535, 5981.3719559445635, 5983.6237665338085, 5987.43119403656, 5902.5277977762535, 5930.377310382521, 5940.376260492586, 5941.0, 5957.49361304294], "unit": "score", "name": "mootools.html", "value": 4398.221628139518}, {"lowerIsBetter": false, "replicates": [343.07027954243995, 349.47404156744096, 350.4987867349692, 354.8962725922381, 355.2841025333954, 5863.79476718315, 5931.377205393436, 5964.761409543613, 5989.490893274066, 5993.46058854703, 5602.579806514517, 5683.403242659513, 5730.226419433376, 5854.268216472941, 5870.26621672291, 4516.367708520794, 4549.954500454986, 4562.270036794113, 4566.862994110182, 4585.403897493321, 4557.156925968707, 4571.657125715568, 4577.382053422779, 4580.083983203356, 4580.221362368388, 4304.440422745039, 4396.472423309191, 4397.428334316551, 4461.308497182926, 4500.302453119772, 4477.26125189345, 4483.170613436492, 4492.415985921842, 4494.640428765691, 4497.10057988402, 4014.979925100356, 4026.255142798592, 4027.496562929634, 4030.0730831908827, 4034.8789536313957, 5602.551795856321, 5602.747876345574, 5603.467670571289, 5608.46719561641, 5614.578906582023, 5171.663841850268, 5293.814716484904, 5308.442613525563, 5317.255584218213, 5318.601104917147, 6123.755049798003, 6166.229221347332, 6171.506279497629, 6176.96911515444, 6177.7837775677635, 4484.798184081724, 4488.192125417424, 4489.9775501122285, 4494.662900282492, 4506.053728716974, 6289.528285378615, 6516.804495865132, 6517.967410162919, 6519.511036672268, 6540.869182616369, 4493.865184044484, 4525.343825145335, 4525.909481810411, 4529.207388707029, 4529.547045295444, 4570.748608826547, 4571.268597024527, 4588.128255631419, 4588.242939914943, 4592.954070459319, 5243.2659427680155, 5247.632665713363, 5250.369955605352, 5254.894902102013, 5254.92117618236, 6067.787627433018, 6257.061440783918, 6268.216472940882, 6298.905516417258, 6310.6213627182515, 1593.6254980079673, 1614.6932082904211, 1614.8292487946146, 1616.1434439746954, 1617.6683779825107, 1063.9042486176127, 1070.796548655753, 1081.9242653014371, 1086.1093902999464, 1100.0, 5944.3164036136395, 5955.851103722442, 5977.0, 5979.880402391927, 5985.850353741104, 6476.643784591893, 6476.740930362827, 6478.611283322922, 6479.514036447285, 6481.189851268591, 5785.103308987113, 5850.64896106235, 5928.970355148197, 5980.401959804072, 6044.546659000593, 3498.0, 3507.14075051614, 3517.9296414071573, 3525.3125640499857, 3528.4530897710897, 6719.764808231688, 6745.59526428406, 6752.0, 6755.0, 6755.932440675629, 6568.310327415553, 6663.700133494004, 6670.866582668416, 6692.899606505906, 6695.531312808057, 6670.132882725215, 6673.499487538454, 6694.564853284521, 6734.191896972395, 6737.663116844138, 6457.806265812033, 6501.609903405811, 6502.479801615765, 6513.804585862432, 6519.152510173647, 6328.6202827830475, 6437.645929473737, 6449.935500644933, 6457.773977910751, 6458.580192287486, 6737.056812046416, 6745.190577130776, 6751.358620931003, 6755.189377274758, 6757.864842703217, 4551.749653768942, 4556.587457888066, 4556.772161391984, 4557.0, 4558.680892337505, 6357.650329231937, 6519.250286217146, 6520.0, 6532.934670653232, 6534.509911756732, 6340.619562826245, 6352.110704501281, 6357.650329231752, 6362.236531616236, 6364.236291645032, 6273.686315684289, 6326.2092238470195, 6340.365963403623, 6342.682865856596, 6345.302016778059, 5994.520438365008, 6177.9691101546005, 6179.536534759821, 6223.190985171898, 6225.470834978896, 6291.96854015727, 6315.115883776367, 6372.36276372359, 6380.202474690664, 6393.1688880445245, 6234.719437625408, 6238.313785483684, 6242.250929888442, 6246.406591373812, 6247.2815626201755], "unit": "score", "name": "prototype.html", "value": 4760.491236750901}, {"lowerIsBetter": false, "replicates": [677.7289084366253, 698.53547390985, 715.5956884360335, 766.2796970847406, 803.7146812881423, 11992.820107698391, 12154.756904861919, 12163.148579599432, 12182.878171218284, 12211.389430528472, 11199.384033878154, 11263.380514071723, 11272.041876440513, 11280.0, 11286.98417142459, 682.0519477925687, 682.6723172877022, 807.6123460738849, 814.6659869453525, 831.7296878514506, 827.0, 828.1221904780922, 834.2033358142959, 835.1898658301438, 835.5863847395517, 866.6706651472432, 874.7463235661651, 875.1817051057282, 875.483464755794, 875.7941883657336, 712.3161764705889, 714.8963400306952, 836.0343802907621, 864.3301441382915, 866.0430224601787, 633.9461145802612, 634.7587916591712, 638.5625846295303, 638.9904151437732, 639.5970538560676, 11395.54417823286, 11396.373199474026, 11467.36929468879, 11474.713132171679, 11485.94257028718, 10415.843762343571, 10491.265611407205, 10518.158547316196, 10912.56349746017, 11323.547058117665, 9541.33210675253, 9707.563159657762, 9738.367006144577, 9767.267454940908, 9908.851367229498, 3478.4608385700003, 3517.7009954153673, 3540.822958852073, 3543.5216245806746, 3609.8014609196484, 46566.5343346569, 46640.300395494094, 46667.76666116682, 46757.766211169066, 46762.766186168854, 9095.909040909639, 9135.13216244469, 9190.49452280131, 9291.394256862746, 9389.295802814817, 18575.628487430175, 18591.16339764687, 18602.906985464986, 18627.90686046561, 18649.0, 6934.514583979174, 7170.211276759553, 7281.927180728231, 7302.780916572511, 7360.631968401559, 3532.5054492371087, 3565.750397472152, 3575.76757510761, 3608.585012723518, 3629.129009037812, 2989.59640448541, 3005.128512731327, 3006.4738670732536, 3010.5484177373132, 3030.499967505337, 546.3416583017455, 547.8630342414397, 556.6743455078824, 568.8208214412447, 582.5310624946874, 504.8359283232964, 581.9272590926134, 595.8063629320488, 603.6649659439054, 617.8362733875526, 7377.483576149725, 7712.614369281513, 7988.0, 8091.514509129471, 8413.621387037598, 494.5153749325681, 537.1191246355979, 543.8857839853675, 571.0919637775874, 631.8009826904511, 3421.4012547804036, 3512.613612502623, 3693.3351996640326, 3722.758020728644, 3754.887353379403, 53685.0, 54163.0, 54213.186802198, 54391.728041359536, 54526.72736636292, 49754.0, 50796.492035079915, 50911.490885091414, 50918.745406273476, 51354.0, 45061.09877802491, 45662.086758265315, 46627.30059049117, 47321.526784731715, 49919.50080499221, 7517.624118794148, 7519.0, 7608.771736847903, 7723.922760772545, 7857.174996625501, 33388.499172512915, 33935.83032084824, 34160.48759268563, 34172.82913585416, 34182.487262691575, 40326.1934761309, 40711.0, 41179.7941010305, 44921.10157796891, 45011.774941125084, 9692.224622030362, 9717.757056073655, 9881.0, 9893.55479003461, 10191.439470829175, 10958.56165753361, 10986.670399888017, 11042.0, 11551.8794448008, 11553.422328883691, 9830.950845245728, 10004.499775011365, 10112.544935477774, 10280.742981425525, 10292.691219263434, 9336.486493242937, 9544.809103818023, 9743.756406089904, 9997.700068997941, 9997.750056248651, 9775.951120244354, 10136.290459668047, 10304.381737095799, 10317.74205644865, 10641.14870810318, 8500.319974402157, 8574.22831945128, 8633.76187479391, 8634.913650863411, 8798.296136309207, 7750.379969602531, 8116.634751436081, 8228.547429891414, 8296.585170741319, 8296.728169973972], "unit": "score", "name": "yui.html", "value": 5857.346941684358}], "name": "dromaeo_css", "value": 6803.79927612213}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 110.0, 104.0, 110.0, 109.0, 110.0, 101.0, 109.0, 109.0, 108.0], "unit": "score", "name": "ai-astar", "value": 107.9}, {"lowerIsBetter": true, "replicates": [152.0, 124.0, 150.0, 161.0, 131.0, 150.0, 150.0, 126.0, 172.0, 129.0], "unit": "score", "name": "audio-beat-detection", "value": 144.5}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 162.0, 161.0, 161.0, 161.0, 159.0, 161.0, 161.0, 160.0], "unit": "score", "name": "audio-dft", "value": 160.9}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 87.0, 99.0, 71.0, 74.0, 71.0, 112.0, 101.0, 71.0], "unit": "score", "name": "audio-fft", "value": 83.1}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 137.0, 96.0, 97.0, 97.0, 142.0, 96.0, 96.0, 141.0], "unit": "score", "name": "audio-oscillator", "value": 109.5}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 111.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 146.0, 146.0, 147.0, 147.0, 145.0, 146.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.2}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 95.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [57.0, 57.0, 57.0, 56.0, 56.0, 56.0, 56.0, 56.0, 56.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 56.1}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 67.0, 67.0, 67.0, 67.0, 68.0, 68.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.2}, {"lowerIsBetter": true, "replicates": [84.0, 84.0, 86.0, 87.0, 86.0, 85.0, 87.0, 85.0, 87.0, 90.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.1}, {"lowerIsBetter": true, "replicates": [121.0, 117.0, 131.0, 116.0, 115.0, 116.0, 123.0, 131.0, 117.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.6}, {"lowerIsBetter": true, "replicates": [153.0, 144.0, 142.0, 150.0, 151.0, 142.0, 149.0, 152.0, 150.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.4}, {"lowerIsBetter": true, "replicates": [68.0, 70.0, 70.0, 70.0, 68.0, 68.0, 69.0, 70.0, 67.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.7}], "name": "kraken", "value": 1503.1999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.12373907195695], "unit": "score", "name": "Richards", "value": 209.97629600000008}, {"lowerIsBetter": false, "replicates": [191.46084625694044], "unit": "score", "name": "DeltaBlue", "value": 345.33431399999995}, {"lowerIsBetter": false, "replicates": [282.0078962210942], "unit": "score", "name": "Encrypt", "value": 943.8778259999998}, {"lowerIsBetter": false, "replicates": [5159.79381443299], "unit": "score", "name": "Decrypt", "value": 51.587526473526495}, {"lowerIsBetter": false, "replicates": [1098.901098901099], "unit": "score", "name": "RayTrace", "value": 673.3899900000001}, {"lowerIsBetter": false, "replicates": [785.5459544383347], "unit": "score", "name": "Earley", "value": 848.4073989999999}, {"lowerIsBetter": false, "replicates": [12329.268292682927], "unit": "score", "name": "Boyer", "value": 54.05535707220569}, {"lowerIsBetter": false, "replicates": [25974.358974358973], "unit": "score", "name": "RegExp", "value": 35.072472852912156}, {"lowerIsBetter": false, "replicates": [628.5355122564425], "unit": "score", "name": "Splay", "value": 129.65218100000004}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 20895.58955298334}]} 11:34:42 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "20895.59"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1503.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6803.80"}}} 11:34:42 INFO - Return code: 0 11:34:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 11:34:42 INFO - # TBPL SUCCESS # 11:34:42 INFO - Running post-action listener: _resource_record_post_action 11:34:42 INFO - Running post-run listener: _resource_record_post_run 11:34:43 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 4096; Write bytes: 588607488; Read time: 12; Write time: 428936 11:34:43 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 191807488; Read time: 0; Write time: 170224 11:34:43 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 4096; Write bytes: 342908928; Read time: 12; Write time: 233368 11:34:43 INFO - Running post-run listener: _upload_blobber_files 11:34:43 INFO - Blob upload gear active. 11:34:43 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 11:34:43 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:34:43 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:34:43 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:34:43 INFO - (blobuploader) - INFO - Open directory for files ... 11:34:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 11:34:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:34:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:34:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:34:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:34:44 INFO - (blobuploader) - INFO - Done attempting. 11:34:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:34:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:34:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:34:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:34:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:34:45 INFO - (blobuploader) - INFO - Done attempting. 11:34:45 INFO - (blobuploader) - INFO - Iteration through files over. 11:34:45 INFO - Return code: 0 11:34:45 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 11:34:45 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 11:34:45 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f037b37ae9762dd719d1dffc1b575f7f0b15993a584cd32b61465e8972ef5d64758634241716d3cd5d02fb2ec89845f056d1afa2dde958a16c1d207b06d2e389", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/72a777fa555e7cda2c5393306506c1f34c84f5ba3e8d2848ec70a49590a31ed14d7460a08acd3fd4c11ba737637d2a47b801e40a7d11e76b5eaa2cd7c7fdbd8b"} 11:34:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 11:34:45 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 11:34:45 INFO - Contents: 11:34:45 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f037b37ae9762dd719d1dffc1b575f7f0b15993a584cd32b61465e8972ef5d64758634241716d3cd5d02fb2ec89845f056d1afa2dde958a16c1d207b06d2e389", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/72a777fa555e7cda2c5393306506c1f34c84f5ba3e8d2848ec70a49590a31ed14d7460a08acd3fd4c11ba737637d2a47b801e40a7d11e76b5eaa2cd7c7fdbd8b"} 11:34:45 INFO - Copying logs to upload dir... 11:34:45 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1266.678480 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-01-04 11:34:45.382827) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-04 11:34:45.386806) ========= 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=03627c79f6bb3d1578c4a402000001ba-1451934817.282862-850247339 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/f037b37ae9762dd719d1dffc1b575f7f0b15993a584cd32b61465e8972ef5d64758634241716d3cd5d02fb2ec89845f056d1afa2dde958a16c1d207b06d2e389", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/72a777fa555e7cda2c5393306506c1f34c84f5ba3e8d2848ec70a49590a31ed14d7460a08acd3fd4c11ba737637d2a47b801e40a7d11e76b5eaa2cd7c7fdbd8b"} build_url:https://queue.taskcluster.net/v1/task/DOZITRv2QXKgWGk0fmwpsQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011273 build_url: 'https://queue.taskcluster.net/v1/task/DOZITRv2QXKgWGk0fmwpsQ/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/f037b37ae9762dd719d1dffc1b575f7f0b15993a584cd32b61465e8972ef5d64758634241716d3cd5d02fb2ec89845f056d1afa2dde958a16c1d207b06d2e389", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/72a777fa555e7cda2c5393306506c1f34c84f5ba3e8d2848ec70a49590a31ed14d7460a08acd3fd4c11ba737637d2a47b801e40a7d11e76b5eaa2cd7c7fdbd8b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-04 11:34:45.412035) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 11:34:45.412379) ========= 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=03627c79f6bb3d1578c4a402000001ba-1451934817.282862-850247339 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004452 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 11:34:45.495401) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-04 11:34:45.495707) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-04 11:34:45.496040) ========= ========= Total master_lag: 0.25 =========