builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-011 starttime: 1451599393.32 results: success (0) buildid: 20151231113015 builduid: fe2ce72207064072ab96a153974b12a7 revision: 163980e9e4646556c12c3bf7852ba6e266ee4236 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-31 14:03:13.318936) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-31 14:03:13.319791) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-31 14:03:13.320311) ========= 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=76a4ffbc7ba64825c1a171dc000001de-1451598936.245095-1445681370 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.005384 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-31 14:03:13.354361) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-31 14:03:13.354694) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-31 14:03:13.394255) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 14:03:13.394562) ========= 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=76a4ffbc7ba64825c1a171dc000001de-1451598936.245095-1445681370 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.033632 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 14:03:13.442966) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-31 14:03:13.443266) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-31 14:03:13.443901) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 14:03:13.444184) ========= 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=76a4ffbc7ba64825c1a171dc000001de-1451598936.245095-1445681370 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-31 14:03:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 233M=0s 2015-12-31 14:03:13 (233 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.257562 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 14:03:13.714742) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 14:03:13.715104) ========= 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=76a4ffbc7ba64825c1a171dc000001de-1451598936.245095-1445681370 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.137644 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 14:03:13.864348) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-31 14:03:13.864720) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 163980e9e4646556c12c3bf7852ba6e266ee4236 --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 163980e9e4646556c12c3bf7852ba6e266ee4236 --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=76a4ffbc7ba64825c1a171dc000001de-1451598936.245095-1445681370 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-31 14:03:13,924 truncating revision to first 12 chars 2015-12-31 14:03:13,924 Setting DEBUG logging. 2015-12-31 14:03:13,925 attempt 1/10 2015-12-31 14:03:13,925 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/163980e9e464?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-31 14:03:14,849 unpacking tar archive at: fx-team-163980e9e464/testing/mozharness/ program finished with exit code 0 elapsedTime=1.196933 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-31 14:03:15.074277) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-31 14:03:15.074593) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-31 14:03:15.082994) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-31 14:03:15.083306) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-31 14:03:15.083716) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2015-12-31 14:03:15.084003) ========= /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=76a4ffbc7ba64825c1a171dc000001de-1451598936.245095-1445681370 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:03:15 INFO - MultiFileLogger online at 20151231 14:03:15 in /builds/slave/test-pgo 14:03:15 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 14:03:15 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 14:03:15 INFO - {'append_to_log': False, 14:03:15 INFO - 'base_work_dir': '/builds/slave/test-pgo', 14:03:15 INFO - 'blob_upload_branch': 'Fx-Team', 14:03:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 14:03:15 INFO - 'branch': 'Fx-Team', 14:03:15 INFO - 'buildbot_json_path': 'buildprops.json', 14:03:15 INFO - 'config_files': ('talos/linux_config.py',), 14:03:15 INFO - 'default_actions': ('clobber', 14:03:15 INFO - 'read-buildbot-config', 14:03:15 INFO - 'download-and-extract', 14:03:15 INFO - 'populate-webroot', 14:03:15 INFO - 'create-virtualenv', 14:03:15 INFO - 'install', 14:03:15 INFO - 'run-tests'), 14:03:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:03:15 INFO - 'download_minidump_stackwalk': True, 14:03:15 INFO - 'download_symbols': 'ondemand', 14:03:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:03:15 INFO - 'tooltool.py': '/tools/tooltool.py', 14:03:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:03:15 INFO - '/tools/misc-python/virtualenv.py')}, 14:03:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:03:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:03:15 INFO - 'installer_path': 'installer.exe', 14:03:15 INFO - 'log_level': 'info', 14:03:15 INFO - 'log_name': 'talos', 14:03:15 INFO - 'log_to_console': True, 14:03:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:03:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:03:15 INFO - 'opt_config_files': (), 14:03:15 INFO - 'pip_index': False, 14:03:15 INFO - 'sps_profile': False, 14:03:15 INFO - 'sps_profile_interval': 0, 14:03:15 INFO - 'suite': 'dromaeojs', 14:03:15 INFO - 'system_bits': '32', 14:03:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:03:15 INFO - 'title': 'talos-linux64-ix-011', 14:03:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:03:15 INFO - 'use_talos_json': True, 14:03:15 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 14:03:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:03:15 INFO - 'work_dir': 'build'} 14:03:15 INFO - ##### 14:03:15 INFO - ##### Running clobber step. 14:03:15 INFO - ##### 14:03:15 INFO - Running pre-action listener: _resource_record_pre_action 14:03:15 INFO - Running main action method: clobber 14:03:15 INFO - rmtree: /builds/slave/test-pgo/build 14:03:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 14:03:22 INFO - Running post-action listener: _resource_record_post_action 14:03:22 INFO - ##### 14:03:22 INFO - ##### Running read-buildbot-config step. 14:03:22 INFO - ##### 14:03:22 INFO - Running pre-action listener: _resource_record_pre_action 14:03:22 INFO - Running main action method: read_buildbot_config 14:03:22 INFO - Using buildbot properties: 14:03:22 INFO - { 14:03:22 INFO - "project": "", 14:03:22 INFO - "product": "firefox", 14:03:22 INFO - "script_repo_revision": "production", 14:03:22 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 14:03:22 INFO - "repository": "", 14:03:22 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 14:03:22 INFO - "buildid": "20151231113015", 14:03:22 INFO - "pgo_build": "True", 14:03:22 INFO - "basedir": "/builds/slave/test-pgo", 14:03:22 INFO - "buildnumber": 564, 14:03:22 INFO - "slavename": "talos-linux64-ix-011", 14:03:22 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 14:03:22 INFO - "platform": "ubuntu64_hw", 14:03:22 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 14:03:22 INFO - "branch": "fx-team", 14:03:22 INFO - "repo_path": "integration/fx-team", 14:03:22 INFO - "revision": "163980e9e4646556c12c3bf7852ba6e266ee4236", 14:03:22 INFO - "stage_platform": "linux64-pgo", 14:03:22 INFO - "builduid": "fe2ce72207064072ab96a153974b12a7", 14:03:22 INFO - "slavebuilddir": "test" 14:03:22 INFO - } 14:03:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/QTRcrkpjQO2wNtnonOtWjw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 14:03:22 INFO - Running post-action listener: _resource_record_post_action 14:03:22 INFO - ##### 14:03:22 INFO - ##### Running download-and-extract step. 14:03:22 INFO - ##### 14:03:22 INFO - Running pre-action listener: _resource_record_pre_action 14:03:22 INFO - Running main action method: download_and_extract 14:03:22 INFO - mkdir: /builds/slave/test-pgo/build/tests 14:03:22 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')]} 14:03:22 INFO - https://queue.taskcluster.net/v1/task/QTRcrkpjQO2wNtnonOtWjw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 14:03:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QTRcrkpjQO2wNtnonOtWjw/artifacts/public/build/test_packages.json 14:03:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QTRcrkpjQO2wNtnonOtWjw/artifacts/public/build/test_packages.json 14:03:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QTRcrkpjQO2wNtnonOtWjw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 14:03:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QTRcrkpjQO2wNtnonOtWjw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 14:03:23 INFO - Downloaded 1302 bytes. 14:03:23 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 14:03:23 INFO - Using the following test package requirements: 14:03:23 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 14:03:23 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:03:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:03:23 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:03:23 INFO - u'jsshell-linux-x86_64.zip'], 14:03:23 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:03:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:03:23 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 14:03:23 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:03:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:03:23 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:03:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:03:23 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:03:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:03:23 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 14:03:23 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:03:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:03:23 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:03:23 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')]} 14:03:23 INFO - https://queue.taskcluster.net/v1/task/QTRcrkpjQO2wNtnonOtWjw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:03:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QTRcrkpjQO2wNtnonOtWjw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:03:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QTRcrkpjQO2wNtnonOtWjw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:03:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QTRcrkpjQO2wNtnonOtWjw/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 14:03:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QTRcrkpjQO2wNtnonOtWjw/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 14:03:25 INFO - Downloaded 23195441 bytes. 14:03:25 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 14:03:25 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:03:25 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 14:03:26 INFO - Return code: 0 14:03:26 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 14:03:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:26 INFO - https://queue.taskcluster.net/v1/task/QTRcrkpjQO2wNtnonOtWjw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:03:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QTRcrkpjQO2wNtnonOtWjw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:03:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QTRcrkpjQO2wNtnonOtWjw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:03:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QTRcrkpjQO2wNtnonOtWjw/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 14:03:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QTRcrkpjQO2wNtnonOtWjw/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 14:03:28 INFO - Downloaded 23195441 bytes. 14:03:28 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 14:03:28 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:03:28 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 14:03:29 INFO - Return code: 0 14:03:29 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')]} 14:03:29 INFO - https://queue.taskcluster.net/v1/task/QTRcrkpjQO2wNtnonOtWjw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:03:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QTRcrkpjQO2wNtnonOtWjw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 14:03:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QTRcrkpjQO2wNtnonOtWjw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 14:03:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QTRcrkpjQO2wNtnonOtWjw/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 14:03:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QTRcrkpjQO2wNtnonOtWjw/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 14:03:30 INFO - Downloaded 11132285 bytes. 14:03:30 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 14:03:30 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 14:03:30 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 14:03:30 INFO - Return code: 0 14:03: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')]} 14:03:30 INFO - https://queue.taskcluster.net/v1/task/QTRcrkpjQO2wNtnonOtWjw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:03:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QTRcrkpjQO2wNtnonOtWjw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:03:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QTRcrkpjQO2wNtnonOtWjw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:03:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QTRcrkpjQO2wNtnonOtWjw/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 14:03:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QTRcrkpjQO2wNtnonOtWjw/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 14:03:32 INFO - Downloaded 54949941 bytes. 14:03:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QTRcrkpjQO2wNtnonOtWjw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:03:32 INFO - mkdir: /builds/slave/test-pgo/properties 14:03:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 14:03:32 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 14:03:32 INFO - Contents: 14:03:32 INFO - build_url:https://queue.taskcluster.net/v1/task/QTRcrkpjQO2wNtnonOtWjw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:03:32 INFO - Running post-action listener: _resource_record_post_action 14:03:32 INFO - Running post-action listener: set_extra_try_arguments 14:03:32 INFO - ##### 14:03:32 INFO - ##### Running populate-webroot step. 14:03:32 INFO - ##### 14:03:32 INFO - Running pre-action listener: _resource_record_pre_action 14:03:32 INFO - Running main action method: populate_webroot 14:03:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:03:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:03:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:03:32 INFO - '--tppagecycles', 14:03:32 INFO - '7'], 14:03:32 INFO - 'tests': ['tsvgm']}}, 14:03:32 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:03:32 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:03:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:03:32 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:03:32 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:03:32 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:03:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:03:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:03:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:03:32 INFO - 'talos_options': ['--e10s'], 14:03:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:03:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:03:32 INFO - 'tests': ['damp', 'tps']}, 14:03:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:03:32 INFO - 'talos_options': ['--e10s'], 14:03:32 INFO - 'tests': ['damp', 'tps']}, 14:03:32 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:03:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:03:32 INFO - 'other': {'tests': ['a11yr', 14:03:32 INFO - 'ts_paint', 14:03:32 INFO - 'tpaint', 14:03:32 INFO - 'sessionrestore', 14:03:32 INFO - 'sessionrestore_no_auto_restore']}, 14:03:32 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:03:32 INFO - 'tests': ['a11yr', 14:03:32 INFO - 'ts_paint', 14:03:32 INFO - 'tpaint', 14:03:32 INFO - 'sessionrestore', 14:03:32 INFO - 'sessionrestore_no_auto_restore']}, 14:03:32 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:03:32 INFO - 'tests': ['a11yr', 14:03:32 INFO - 'ts_paint', 14:03:32 INFO - 'tpaint', 14:03:32 INFO - 'sessionrestore', 14:03:32 INFO - 'sessionrestore_no_auto_restore']}, 14:03:32 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:03:32 INFO - 'tests': ['a11yr', 14:03:32 INFO - 'ts_paint', 14:03:32 INFO - 'tpaint', 14:03:32 INFO - 'sessionrestore', 14:03:32 INFO - 'sessionrestore_no_auto_restore']}, 14:03:32 INFO - 'other_l64': {'tests': ['a11yr', 14:03:32 INFO - 'ts_paint', 14:03:32 INFO - 'tpaint', 14:03:32 INFO - 'sessionrestore', 14:03:32 INFO - 'sessionrestore_no_auto_restore']}, 14:03:32 INFO - 'other_nol64': {'tests': ['a11yr', 14:03:32 INFO - 'ts_paint', 14:03:32 INFO - 'tpaint', 14:03:32 INFO - 'sessionrestore', 14:03:32 INFO - 'sessionrestore_no_auto_restore']}, 14:03:32 INFO - 'svgr': {'tests': ['tsvgx', 14:03:32 INFO - 'tsvgr_opacity', 14:03:32 INFO - 'tart', 14:03:32 INFO - 'tscrollx', 14:03:32 INFO - 'cart']}, 14:03:32 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:03:32 INFO - 'tests': ['tsvgx', 14:03:32 INFO - 'tsvgr_opacity', 14:03:32 INFO - 'tart', 14:03:32 INFO - 'tscrollx', 14:03:32 INFO - 'cart']}, 14:03:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:03:32 INFO - 'tests': ['tp5o']}, 14:03:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:03:32 INFO - 'talos_options': ['--e10s'], 14:03:32 INFO - 'tests': ['tp5o']}, 14:03:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:03:32 INFO - 'talos_options': ['--xperf_path', 14:03:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:03:32 INFO - 'tests': ['tp5n']}, 14:03:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:03:32 INFO - 'talos_options': ['--e10s', 14:03:32 INFO - '--xperf_path', 14:03:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:03:32 INFO - 'tests': ['tp5n']}}, 14:03:32 INFO - 'talos.zip': {'path': '', 14:03:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:03:32 INFO - Running post-action listener: _resource_record_post_action 14:03:32 INFO - ##### 14:03:32 INFO - ##### Running create-virtualenv step. 14:03:32 INFO - ##### 14:03:32 INFO - Running pre-action listener: _resource_record_pre_action 14:03:32 INFO - Running main action method: create_virtualenv 14:03:32 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 14:03:32 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 14:03:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 14:03:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:03:32 INFO - Using real prefix '/usr' 14:03:32 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 14:03:32 INFO - Installing distribute.............................................................................................................................................................................................done. 14:03:34 INFO - Installing pip.................done. 14:03:34 INFO - Return code: 0 14:03:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 14:03:34 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')]} 14:03:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:03:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:34 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')]} 14:03:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:03:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:34 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 0x7f2671834f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ac6c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a9e40>, '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 0x29aa740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29aabf0>, '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': '76a4ffbc7ba64825c1a171dc000001de-1451598936.245095-1445681370', '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 14:03:34 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 14:03:34 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 14:03:34 INFO - Using env: {'DISPLAY': ':0', 14:03:34 INFO - 'HOME': '/home/cltbld', 14:03:34 INFO - 'LANG': 'en_US.UTF-8', 14:03:34 INFO - 'LANGUAGE': 'en_US:en', 14:03:34 INFO - 'LOGNAME': 'cltbld', 14:03:34 INFO - 'MAIL': '/var/mail/cltbld', 14:03:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:34 INFO - 'MOZ_NO_REMOTE': '1', 14:03:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:34 INFO - 'NO_EM_RESTART': '1', 14:03:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:03:34 INFO - 'PWD': '/builds/slave/test-pgo', 14:03:34 INFO - 'SHELL': '/bin/bash', 14:03:34 INFO - 'SHLVL': '1', 14:03:34 INFO - 'TERM': 'linux', 14:03:34 INFO - 'TMOUT': '86400', 14:03:34 INFO - 'USER': 'cltbld', 14:03:34 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1451598936.245095-1445681370', 14:03:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:34 INFO - '_': '/tools/buildbot/bin/python'} 14:03:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:34 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 14:03:34 INFO - Cleaning up... 14:03:34 INFO - Return code: 0 14:03:34 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 14:03:34 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')]} 14:03:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:03:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:34 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')]} 14:03:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:03:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:34 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 0x7f2671834f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ac6c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a9e40>, '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 0x29aa740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29aabf0>, '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': '76a4ffbc7ba64825c1a171dc000001de-1451598936.245095-1445681370', '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 14:03:34 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 14:03:34 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 14:03:34 INFO - Using env: {'DISPLAY': ':0', 14:03:34 INFO - 'HOME': '/home/cltbld', 14:03:34 INFO - 'LANG': 'en_US.UTF-8', 14:03:34 INFO - 'LANGUAGE': 'en_US:en', 14:03:34 INFO - 'LOGNAME': 'cltbld', 14:03:34 INFO - 'MAIL': '/var/mail/cltbld', 14:03:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:34 INFO - 'MOZ_NO_REMOTE': '1', 14:03:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:34 INFO - 'NO_EM_RESTART': '1', 14:03:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:03:34 INFO - 'PWD': '/builds/slave/test-pgo', 14:03:34 INFO - 'SHELL': '/bin/bash', 14:03:34 INFO - 'SHLVL': '1', 14:03:34 INFO - 'TERM': 'linux', 14:03:34 INFO - 'TMOUT': '86400', 14:03:34 INFO - 'USER': 'cltbld', 14:03:34 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1451598936.245095-1445681370', 14:03:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:34 INFO - '_': '/tools/buildbot/bin/python'} 14:03:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:35 INFO - Downloading/unpacking psutil>=0.7.1 14:03:35 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 14:03:35 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 14:03:35 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 14:03:35 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 14:03:35 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 14:03:35 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 14:03:36 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 14:03:36 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 14:03:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 14:03:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:03:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:03:36 INFO - Installing collected packages: psutil 14:03:36 INFO - Running setup.py install for psutil 14:03:37 INFO - building 'psutil._psutil_linux' extension 14:03:37 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 14:03:37 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 14:03:37 INFO - building 'psutil._psutil_posix' extension 14:03:37 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 14:03:38 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 14:03:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:03:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:03:38 INFO - Successfully installed psutil 14:03:38 INFO - Cleaning up... 14:03:38 INFO - Return code: 0 14:03:38 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 14:03:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:03:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:03:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:38 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 0x7f2671834f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ac6c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a9e40>, '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 0x29aa740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29aabf0>, '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': '76a4ffbc7ba64825c1a171dc000001de-1451598936.245095-1445681370', '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 14:03:38 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 14:03:38 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 14:03:38 INFO - Using env: {'DISPLAY': ':0', 14:03:38 INFO - 'HOME': '/home/cltbld', 14:03:38 INFO - 'LANG': 'en_US.UTF-8', 14:03:38 INFO - 'LANGUAGE': 'en_US:en', 14:03:38 INFO - 'LOGNAME': 'cltbld', 14:03:38 INFO - 'MAIL': '/var/mail/cltbld', 14:03:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:38 INFO - 'MOZ_NO_REMOTE': '1', 14:03:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:38 INFO - 'NO_EM_RESTART': '1', 14:03:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:03:38 INFO - 'PWD': '/builds/slave/test-pgo', 14:03:38 INFO - 'SHELL': '/bin/bash', 14:03:38 INFO - 'SHLVL': '1', 14:03:38 INFO - 'TERM': 'linux', 14:03:38 INFO - 'TMOUT': '86400', 14:03:38 INFO - 'USER': 'cltbld', 14:03:38 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1451598936.245095-1445681370', 14:03:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:38 INFO - '_': '/tools/buildbot/bin/python'} 14:03:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:38 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:03:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:40 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:03:40 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 14:03:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:03:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:03:40 INFO - Installing collected packages: mozsystemmonitor 14:03:40 INFO - Running setup.py install for mozsystemmonitor 14:03:40 INFO - Successfully installed mozsystemmonitor 14:03:40 INFO - Cleaning up... 14:03:40 INFO - Return code: 0 14:03:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 14:03:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:03:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:03:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:40 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 0x7f2671834f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ac6c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a9e40>, '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 0x29aa740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29aabf0>, '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': '76a4ffbc7ba64825c1a171dc000001de-1451598936.245095-1445681370', '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 14:03:40 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 14:03:40 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 14:03:40 INFO - Using env: {'DISPLAY': ':0', 14:03:40 INFO - 'HOME': '/home/cltbld', 14:03:40 INFO - 'LANG': 'en_US.UTF-8', 14:03:40 INFO - 'LANGUAGE': 'en_US:en', 14:03:40 INFO - 'LOGNAME': 'cltbld', 14:03:40 INFO - 'MAIL': '/var/mail/cltbld', 14:03:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:40 INFO - 'MOZ_NO_REMOTE': '1', 14:03:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:40 INFO - 'NO_EM_RESTART': '1', 14:03:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:03:40 INFO - 'PWD': '/builds/slave/test-pgo', 14:03:40 INFO - 'SHELL': '/bin/bash', 14:03:40 INFO - 'SHLVL': '1', 14:03:40 INFO - 'TERM': 'linux', 14:03:40 INFO - 'TMOUT': '86400', 14:03:40 INFO - 'USER': 'cltbld', 14:03:40 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1451598936.245095-1445681370', 14:03:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:40 INFO - '_': '/tools/buildbot/bin/python'} 14:03:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:40 INFO - Downloading/unpacking blobuploader==1.2.4 14:03:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:42 INFO - Downloading blobuploader-1.2.4.tar.gz 14:03:42 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 14:03:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:03:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:03:42 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 14:03:42 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 14:03:42 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 14:03:42 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 14:03:42 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 14:03:42 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 14:03:42 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 14:03:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 14:03:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:03:42 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 14:03:42 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 14:03:42 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 14:03:42 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 14:03:42 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 14:03:42 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 14:03:42 INFO - Downloading docopt-0.6.1.tar.gz 14:03:42 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 14:03:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 14:03:42 INFO - Installing collected packages: blobuploader, requests, docopt 14:03:42 INFO - Running setup.py install for blobuploader 14:03:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:03:43 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 14:03:43 INFO - Running setup.py install for requests 14:03:43 INFO - Running setup.py install for docopt 14:03:43 INFO - Successfully installed blobuploader requests docopt 14:03:43 INFO - Cleaning up... 14:03:43 INFO - Return code: 0 14:03:43 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:03:43 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')]} 14:03:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:03:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:43 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')]} 14:03:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:03:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:43 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 0x7f2671834f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ac6c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a9e40>, '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 0x29aa740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29aabf0>, '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': '76a4ffbc7ba64825c1a171dc000001de-1451598936.245095-1445681370', '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 14:03:43 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 14:03:43 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 14:03:43 INFO - Using env: {'DISPLAY': ':0', 14:03:43 INFO - 'HOME': '/home/cltbld', 14:03:43 INFO - 'LANG': 'en_US.UTF-8', 14:03:43 INFO - 'LANGUAGE': 'en_US:en', 14:03:43 INFO - 'LOGNAME': 'cltbld', 14:03:43 INFO - 'MAIL': '/var/mail/cltbld', 14:03:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:43 INFO - 'MOZ_NO_REMOTE': '1', 14:03:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:43 INFO - 'NO_EM_RESTART': '1', 14:03:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:03:43 INFO - 'PWD': '/builds/slave/test-pgo', 14:03:43 INFO - 'SHELL': '/bin/bash', 14:03:43 INFO - 'SHLVL': '1', 14:03:43 INFO - 'TERM': 'linux', 14:03:43 INFO - 'TMOUT': '86400', 14:03:43 INFO - 'USER': 'cltbld', 14:03:43 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1451598936.245095-1445681370', 14:03:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:43 INFO - '_': '/tools/buildbot/bin/python'} 14:03:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:03:43 INFO - Running setup.py (path:/tmp/pip-kqztJn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:03:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:03:43 INFO - Running setup.py (path:/tmp/pip-ZDJjQA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:03:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:03:43 INFO - Running setup.py (path:/tmp/pip-G19vx0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:03:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:03:43 INFO - Running setup.py (path:/tmp/pip-OUj7Ig-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:03:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 14:03:44 INFO - Running setup.py (path:/tmp/pip-Aq986V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 14:03:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:03:44 INFO - Running setup.py (path:/tmp/pip-Ghk0cq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:03:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:03:44 INFO - Running setup.py (path:/tmp/pip-j2LjHE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:03:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:03:44 INFO - Running setup.py (path:/tmp/pip-Ve2Wq4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:03:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 14:03:44 INFO - Running setup.py (path:/tmp/pip-oCAEAL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 14:03:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 14:03:44 INFO - Running setup.py (path:/tmp/pip-fnxOq9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 14:03:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:03:44 INFO - Running setup.py (path:/tmp/pip-s981LK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:03:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:03:44 INFO - Running setup.py (path:/tmp/pip-ujmHfN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:03:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:03:44 INFO - Running setup.py (path:/tmp/pip-tU3X3o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:03:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:03:44 INFO - Running setup.py (path:/tmp/pip-YBryLi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:03:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:03:44 INFO - Running setup.py (path:/tmp/pip-O8Gtkd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:03:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 14:03:44 INFO - Running setup.py (path:/tmp/pip-rQ00aE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 14:03:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 14:03:44 INFO - Running setup.py (path:/tmp/pip-MTShPD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 14:03:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:03:44 INFO - Running setup.py install for manifestparser 14:03:45 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 14:03:45 INFO - Running setup.py install for mozcrash 14:03:45 INFO - Running setup.py install for mozdebug 14:03:45 INFO - Running setup.py install for mozdevice 14:03:45 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 14:03:45 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 14:03:45 INFO - Running setup.py install for mozfile 14:03:45 INFO - Running setup.py install for mozhttpd 14:03:45 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 14:03:45 INFO - Running setup.py install for mozinfo 14:03:45 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 14:03:45 INFO - Running setup.py install for mozInstall 14:03:45 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 14:03:45 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 14:03:45 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 14:03:45 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 14:03:45 INFO - Running setup.py install for mozleak 14:03:45 INFO - Running setup.py install for mozlog 14:03:45 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 14:03:45 INFO - Running setup.py install for moznetwork 14:03:46 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 14:03:46 INFO - Running setup.py install for mozprocess 14:03:46 INFO - Running setup.py install for mozprofile 14:03:46 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 14:03:46 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 14:03:46 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 14:03:46 INFO - Running setup.py install for mozrunner 14:03:46 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 14:03:46 INFO - Running setup.py install for mozscreenshot 14:03:46 INFO - Running setup.py install for moztest 14:03:46 INFO - Running setup.py install for mozversion 14:03:46 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 14:03:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:03:46 INFO - Cleaning up... 14:03:46 INFO - Return code: 0 14:03:46 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:03:46 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')]} 14:03:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:03:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:46 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')]} 14:03:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:03:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:46 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 0x7f2671834f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ac6c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a9e40>, '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 0x29aa740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29aabf0>, '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': '76a4ffbc7ba64825c1a171dc000001de-1451598936.245095-1445681370', '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 14:03:46 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 14:03:46 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 14:03:46 INFO - Using env: {'DISPLAY': ':0', 14:03:46 INFO - 'HOME': '/home/cltbld', 14:03:46 INFO - 'LANG': 'en_US.UTF-8', 14:03:46 INFO - 'LANGUAGE': 'en_US:en', 14:03:46 INFO - 'LOGNAME': 'cltbld', 14:03:46 INFO - 'MAIL': '/var/mail/cltbld', 14:03:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:46 INFO - 'MOZ_NO_REMOTE': '1', 14:03:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:46 INFO - 'NO_EM_RESTART': '1', 14:03:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:03:46 INFO - 'PWD': '/builds/slave/test-pgo', 14:03:46 INFO - 'SHELL': '/bin/bash', 14:03:46 INFO - 'SHLVL': '1', 14:03:46 INFO - 'TERM': 'linux', 14:03:46 INFO - 'TMOUT': '86400', 14:03:46 INFO - 'USER': 'cltbld', 14:03:46 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1451598936.245095-1445681370', 14:03:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:46 INFO - '_': '/tools/buildbot/bin/python'} 14:03:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:03:46 INFO - Running setup.py (path:/tmp/pip-x1CJPu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:03:47 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)) 14:03:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:03:47 INFO - Running setup.py (path:/tmp/pip-U8ty8z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:03:47 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)) 14:03:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:03:47 INFO - Running setup.py (path:/tmp/pip-JmeTbe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:03:47 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)) 14:03:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:03:47 INFO - Running setup.py (path:/tmp/pip-NS6pfC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:03:47 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)) 14:03:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 14:03:47 INFO - Running setup.py (path:/tmp/pip-gsqZPj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 14:03:47 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)) 14:03:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:03:47 INFO - Running setup.py (path:/tmp/pip-lzpAZD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:03:47 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)) 14:03:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:03:47 INFO - Running setup.py (path:/tmp/pip-lu0jAA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:03:47 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)) 14:03:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:03:47 INFO - Running setup.py (path:/tmp/pip-3gAVnW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:03:47 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)) 14:03:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 14:03:47 INFO - Running setup.py (path:/tmp/pip-WRh36i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 14:03:47 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)) 14:03:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 14:03:47 INFO - Running setup.py (path:/tmp/pip-d0hAHu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 14:03:47 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)) 14:03:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:03:47 INFO - Running setup.py (path:/tmp/pip-MIYdT2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:03:47 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)) 14:03:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:03:47 INFO - Running setup.py (path:/tmp/pip-l8ydaO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:03:47 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)) 14:03:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:03:47 INFO - Running setup.py (path:/tmp/pip-FVSkvn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:03:47 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)) 14:03:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:03:47 INFO - Running setup.py (path:/tmp/pip-8ANWhT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:03:47 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)) 14:03:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:03:47 INFO - Running setup.py (path:/tmp/pip-5JfQXd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:03:48 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)) 14:03:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 14:03:48 INFO - Running setup.py (path:/tmp/pip-mIhnry-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 14:03:48 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)) 14:03:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 14:03:48 INFO - Running setup.py (path:/tmp/pip-38iFW2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 14:03:48 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)) 14:03:48 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)) 14:03:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 14:03:48 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)) 14:03:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 14:03:48 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)) 14:03:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 14:03:48 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 14:03:48 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 14:03:48 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 14:03:48 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 14:03:48 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 14:03:48 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 14:03:49 INFO - Downloading blessings-1.5.1.tar.gz 14:03:50 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 14:03:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 14:03:50 INFO - Installing collected packages: blessings 14:03:50 INFO - Running setup.py install for blessings 14:03:50 INFO - Successfully installed blessings 14:03:50 INFO - Cleaning up... 14:03:50 INFO - Return code: 0 14:03:50 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 14:03:50 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 14:03:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 14:03:50 INFO - Reading from file tmpfile_stdout 14:03:50 INFO - Current package versions: 14:03:50 INFO - argparse == 1.2.1 14:03:50 INFO - blessings == 1.5.1 14:03:50 INFO - blobuploader == 1.2.4 14:03:50 INFO - docopt == 0.6.1 14:03:50 INFO - manifestparser == 1.1 14:03:50 INFO - mozInstall == 1.12 14:03:50 INFO - mozcrash == 0.16 14:03:50 INFO - mozdebug == 0.1 14:03:50 INFO - mozdevice == 0.47 14:03:50 INFO - mozfile == 1.2 14:03:50 INFO - mozhttpd == 0.7 14:03:50 INFO - mozinfo == 0.9 14:03:50 INFO - mozleak == 0.1 14:03:50 INFO - mozlog == 3.1 14:03:50 INFO - moznetwork == 0.27 14:03:50 INFO - mozprocess == 0.22 14:03:50 INFO - mozprofile == 0.28 14:03:50 INFO - mozrunner == 6.11 14:03:50 INFO - mozscreenshot == 0.1 14:03:50 INFO - mozsystemmonitor == 0.0 14:03:50 INFO - moztest == 0.7 14:03:50 INFO - mozversion == 1.4 14:03:50 INFO - psutil == 3.1.1 14:03:50 INFO - requests == 1.2.3 14:03:50 INFO - wsgiref == 0.1.2 14:03:50 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:03:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:03:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:03:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:50 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 0x7f2671834f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ac6c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a9e40>, '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 0x29aa740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29aabf0>, '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': '76a4ffbc7ba64825c1a171dc000001de-1451598936.245095-1445681370', '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 14:03:50 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 14:03:50 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 14:03:50 INFO - Using env: {'DISPLAY': ':0', 14:03:50 INFO - 'HOME': '/home/cltbld', 14:03:50 INFO - 'LANG': 'en_US.UTF-8', 14:03:50 INFO - 'LANGUAGE': 'en_US:en', 14:03:50 INFO - 'LOGNAME': 'cltbld', 14:03:50 INFO - 'MAIL': '/var/mail/cltbld', 14:03:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:50 INFO - 'MOZ_NO_REMOTE': '1', 14:03:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:50 INFO - 'NO_EM_RESTART': '1', 14:03:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:03:50 INFO - 'PWD': '/builds/slave/test-pgo', 14:03:50 INFO - 'SHELL': '/bin/bash', 14:03:50 INFO - 'SHLVL': '1', 14:03:50 INFO - 'TERM': 'linux', 14:03:50 INFO - 'TMOUT': '86400', 14:03:50 INFO - 'USER': 'cltbld', 14:03:50 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1451598936.245095-1445681370', 14:03:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:50 INFO - '_': '/tools/buildbot/bin/python'} 14:03:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:50 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)) 14:03:50 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)) 14:03:50 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)) 14:03:50 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)) 14:03:50 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)) 14:03:50 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)) 14:03:50 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)) 14:03:50 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)) 14:03:50 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)) 14:03:50 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)) 14:03:50 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)) 14:03:50 INFO - Cleaning up... 14:03:50 INFO - Return code: 0 14:03:50 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 14:03:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:03:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:03:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:50 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 0x7f2671834f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ac6c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a9e40>, '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 0x29aa740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29aabf0>, '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': '76a4ffbc7ba64825c1a171dc000001de-1451598936.245095-1445681370', '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 14:03:50 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 14:03:50 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 14:03:50 INFO - Using env: {'DISPLAY': ':0', 14:03:50 INFO - 'HOME': '/home/cltbld', 14:03:50 INFO - 'LANG': 'en_US.UTF-8', 14:03:50 INFO - 'LANGUAGE': 'en_US:en', 14:03:50 INFO - 'LOGNAME': 'cltbld', 14:03:50 INFO - 'MAIL': '/var/mail/cltbld', 14:03:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:50 INFO - 'MOZ_NO_REMOTE': '1', 14:03:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:50 INFO - 'NO_EM_RESTART': '1', 14:03:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:03:50 INFO - 'PWD': '/builds/slave/test-pgo', 14:03:50 INFO - 'SHELL': '/bin/bash', 14:03:50 INFO - 'SHLVL': '1', 14:03:50 INFO - 'TERM': 'linux', 14:03:50 INFO - 'TMOUT': '86400', 14:03:50 INFO - 'USER': 'cltbld', 14:03:50 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1451598936.245095-1445681370', 14:03:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:50 INFO - '_': '/tools/buildbot/bin/python'} 14:03:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:50 INFO - Downloading/unpacking jsonschema 14:03:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:03:52 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 14:03:52 INFO - Downloading/unpacking functools32 (from jsonschema) 14:03:52 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 14:03:52 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 14:03:52 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 14:03:52 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 14:03:52 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 14:03:52 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 14:03:52 INFO - Downloading functools32-3.2.3-2.tar.gz 14:03:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 14:03:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 14:03:52 INFO - warning: no files found matching '*.txt' 14:03:52 INFO - no previously-included directories found matching 'build' 14:03:52 INFO - no previously-included directories found matching 'dist' 14:03:52 INFO - no previously-included directories found matching '.git*' 14:03:52 INFO - Installing collected packages: jsonschema, functools32 14:03:52 INFO - Running setup.py install for functools32 14:03:53 INFO - warning: no files found matching '*.txt' 14:03:53 INFO - no previously-included directories found matching 'build' 14:03:53 INFO - no previously-included directories found matching 'dist' 14:03:53 INFO - no previously-included directories found matching '.git*' 14:03:53 INFO - Successfully installed jsonschema functools32 14:03:53 INFO - Cleaning up... 14:03:53 INFO - Return code: 0 14:03:53 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 14:03: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')]} 14:03:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:03:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03: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')]} 14:03:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:03:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2671834f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ac6c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a9e40>, '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 0x29aa740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29aabf0>, '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': '76a4ffbc7ba64825c1a171dc000001de-1451598936.245095-1445681370', '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 14:03: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', 'flake8'] in /builds/slave/test-pgo/build 14:03: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 flake8 14:03:53 INFO - Using env: {'DISPLAY': ':0', 14:03:53 INFO - 'HOME': '/home/cltbld', 14:03:53 INFO - 'LANG': 'en_US.UTF-8', 14:03:53 INFO - 'LANGUAGE': 'en_US:en', 14:03:53 INFO - 'LOGNAME': 'cltbld', 14:03:53 INFO - 'MAIL': '/var/mail/cltbld', 14:03:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:53 INFO - 'MOZ_NO_REMOTE': '1', 14:03:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:53 INFO - 'NO_EM_RESTART': '1', 14:03:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:03:53 INFO - 'PWD': '/builds/slave/test-pgo', 14:03:53 INFO - 'SHELL': '/bin/bash', 14:03:53 INFO - 'SHLVL': '1', 14:03:53 INFO - 'TERM': 'linux', 14:03:53 INFO - 'TMOUT': '86400', 14:03:53 INFO - 'USER': 'cltbld', 14:03:53 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1451598936.245095-1445681370', 14:03:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:53 INFO - '_': '/tools/buildbot/bin/python'} 14:03:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:53 INFO - Downloading/unpacking flake8 14:03: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 14:03: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 14:03: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 14:03: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 14:03: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 14:03: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 14:03:54 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:03:54 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 14:03:54 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:03:54 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 14:03:54 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 14:03:54 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 14:03:54 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 14:03:54 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 14:03:54 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 14:03:55 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:03:55 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 14:03:55 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:03:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:55 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 14:03:55 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:03:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 14:03:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 14:03:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:03:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:03:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:03:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:03:55 INFO - no previously-included directories found matching 'docs/_build' 14:03:55 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:03:55 INFO - Running setup.py install for pep8 14:03:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:03:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:03:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:03:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:03:55 INFO - no previously-included directories found matching 'docs/_build' 14:03:55 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 14:03:55 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:03:55 INFO - Cleaning up... 14:03:55 INFO - Return code: 0 14:03:55 INFO - Running post-action listener: _resource_record_post_action 14:03:55 INFO - Running post-action listener: _start_resource_monitoring 14:03:55 INFO - Starting resource monitoring. 14:03:55 INFO - ##### 14:03:55 INFO - ##### Running install step. 14:03:55 INFO - ##### 14:03:55 INFO - Running pre-action listener: _resource_record_pre_action 14:03:55 INFO - Running main action method: install 14:03:55 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 14:03:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 14:03:56 INFO - Reading from file tmpfile_stdout 14:03:56 INFO - Detecting whether we're running mozinstall >=1.0... 14:03:56 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 14:03:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 14:03:56 INFO - Reading from file tmpfile_stdout 14:03:56 INFO - Output received: 14:03:56 INFO - Usage: mozinstall [options] installer 14:03:56 INFO - Options: 14:03:56 INFO - -h, --help show this help message and exit 14:03:56 INFO - -d DEST, --destination=DEST 14:03:56 INFO - Directory to install application into. [default: 14:03:56 INFO - "/builds/slave/test-pgo"] 14:03:56 INFO - --app=APP Application being installed. [default: firefox] 14:03:56 INFO - mkdir: /builds/slave/test-pgo/build/application 14:03:56 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'] 14:03:56 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 14:04:12 INFO - Reading from file tmpfile_stdout 14:04:12 INFO - Output received: 14:04:12 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 14:04:12 INFO - Running post-action listener: _resource_record_post_action 14:04:12 INFO - ##### 14:04:12 INFO - ##### Running run-tests step. 14:04:12 INFO - ##### 14:04:12 INFO - Running pre-action listener: _resource_record_pre_action 14:04:12 INFO - Running main action method: run_tests 14:04:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 14:04:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 14:04:12 INFO - Python 2.7.3 14:04:12 INFO - Return code: 0 14:04:12 INFO - grabbing minidump binary from tooltool 14:04:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:04:12 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 0x29a9e40>, '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 0x29aa740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29aabf0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 14:04:12 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 14:04:12 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 14:04:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:04:12 INFO - Return code: 0 14:04:12 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 14:04:12 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 14:04:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 14:04:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 14:04:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 14:04:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 14:04:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 14:04:13 INFO - Return code: 0 14:04:13 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/QTRcrkpjQO2wNtnonOtWjw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 14:04:13 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/QTRcrkpjQO2wNtnonOtWjw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --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 14:04:13 INFO - Using env: {'DISPLAY': ':0', 14:04:13 INFO - 'HOME': '/home/cltbld', 14:04:13 INFO - 'LANG': 'en_US.UTF-8', 14:04:13 INFO - 'LANGUAGE': 'en_US:en', 14:04:13 INFO - 'LOGNAME': 'cltbld', 14:04:13 INFO - 'MAIL': '/var/mail/cltbld', 14:04:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 14:04:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 14:04:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:04:13 INFO - 'MOZ_NO_REMOTE': '1', 14:04:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 14:04:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:04:13 INFO - 'NO_EM_RESTART': '1', 14:04:13 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:04:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:04:13 INFO - 'PWD': '/builds/slave/test-pgo', 14:04:13 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 14:04:13 INFO - 'SHELL': '/bin/bash', 14:04:13 INFO - 'SHLVL': '1', 14:04:13 INFO - 'TERM': 'linux', 14:04:13 INFO - 'TMOUT': '86400', 14:04:13 INFO - 'USER': 'cltbld', 14:04:13 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1451598936.245095-1445681370', 14:04:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:04:13 INFO - '_': '/tools/buildbot/bin/python'} 14:04:13 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/QTRcrkpjQO2wNtnonOtWjw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 14:04:13 INFO - mozversion application_buildid: 20151231113015 14:04:13 INFO - mozversion application_changeset: 163980e9e4646556c12c3bf7852ba6e266ee4236 14:04:13 INFO - mozversion application_display_name: Nightly 14:04:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:04:13 INFO - mozversion application_name: Firefox 14:04:13 INFO - mozversion application_remotingname: firefox 14:04:13 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:04:13 INFO - mozversion application_vendor: Mozilla 14:04:13 INFO - mozversion application_version: 46.0a1 14:04:13 INFO - mozversion platform_buildid: 20151231113015 14:04:13 INFO - mozversion platform_changeset: 163980e9e4646556c12c3bf7852ba6e266ee4236 14:04:13 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:04:13 INFO - mozversion platform_version: 46.0a1 14:04:13 INFO - using testdate: 1451599453 14:04:13 INFO - actual date: 1451599453 14:04:13 INFO - starting webserver on 'localhost:53406' 14:04:13 INFO - SUITE-START | Running 3 tests 14:04:13 INFO - TEST-START | dromaeo_css 14:04:13 INFO - operating with platform_type : linux_ 14:04:13 INFO - Initialising browser for dromaeo_css test... 14:04:13 INFO - TEST-INFO | started process 17475 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpG2UkkL/profile http://localhost:53406/getInfo.html) 14:04:19 INFO - PROCESS | 17475 | __metrics Screen width/height:1600/1200 14:04:19 INFO - PROCESS | 17475 | colorDepth:24 14:04:19 INFO - PROCESS | 17475 | Browser inner width/height: 1024/697 14:04:19 INFO - PROCESS | 17475 | __metrics 14:04:19 INFO - PROCESS | 17475 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:04:19 INFO - PROCESS | 17475 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:04:20 INFO - TEST-INFO | 17475: exit 0 14:04:20 INFO - Browser initialized. 14:04:20 INFO - Running cycle 1/1 for dromaeo_css test... 14:04:20 INFO - TEST-INFO | started process 17569 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpG2UkkL/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:04:32 INFO - PROCESS | 17569 | RSS: Main: 150593536 14:04:32 INFO - PROCESS | 17569 | 14:05:24 INFO - PROCESS | 17569 | 1451599524349 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] 14:07:33 INFO - PROCESS | 17569 | Cycle 1(1): loaded http://localhost:53406/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53406/tests/dromaeo/cssquery-ext.html) 14:07:34 INFO - PROCESS | 17569 | RSS: Main: 245776384 14:07:34 INFO - PROCESS | 17569 | 14:10:36 INFO - PROCESS | 17569 | Cycle 1(1): loaded http://localhost:53406/tests/dromaeo/cssquery-ext.html (next: http://localhost:53406/tests/dromaeo/cssquery-jquery.html) 14:10:37 INFO - PROCESS | 17569 | RSS: Main: 233861120 14:10:37 INFO - PROCESS | 17569 | 14:13:39 INFO - PROCESS | 17569 | Cycle 1(1): loaded http://localhost:53406/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53406/tests/dromaeo/cssquery-mootools.html) 14:13:39 INFO - PROCESS | 17569 | RSS: Main: 228466688 14:13:39 INFO - PROCESS | 17569 | 14:16:41 INFO - PROCESS | 17569 | Cycle 1(1): loaded http://localhost:53406/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53406/tests/dromaeo/cssquery-prototype.html) 14:16:42 INFO - PROCESS | 17569 | RSS: Main: 215400448 14:16:42 INFO - PROCESS | 17569 | 14:19:44 INFO - PROCESS | 17569 | Cycle 1(1): loaded http://localhost:53406/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53406/tests/dromaeo/cssquery-yui.html) 14:19:45 INFO - PROCESS | 17569 | RSS: Main: 219340800 14:19:45 INFO - PROCESS | 17569 | 14:22:48 INFO - PROCESS | 17569 | Cycle 1(1): loaded http://localhost:53406/tests/dromaeo/cssquery-yui.html (next: http://localhost:53406/tests/dromaeo/cssquery-dojo.html) 14:22:48 INFO - PROCESS | 17569 | RSS: Main: 293855232 14:22:48 INFO - PROCESS | 17569 | 14:22:48 INFO - PROCESS | 17569 | __start_tp_report 14:22:48 INFO - PROCESS | 17569 | _x_x_mozilla_page_load 14:22:48 INFO - PROCESS | 17569 | _x_x_mozilla_page_load_details 14:22:48 INFO - PROCESS | 17569 | |i|pagename|runs| 14:22:48 INFO - PROCESS | 17569 | |0;dojo.html;3110.7666924980626;3140.71733543981;3174.3016536362006;3178.3961047400994;3211.10089175031;5042.294078828967;5222.399424066233;5234.92147617786;5240.161574148137;5286.418493965661;5191.558717509007;5196;5231.555317797992;5234.528892399683;5312.309399778023;4774.307725379836;4796.3045358423005;4844.781984810692;4904.239842824368;4919.040787046527;4853.927191092136;4854.684445511049;4931.235658472924;4934.383202099738;4935.5804756595735;4748.7863046163;4750.643701722384;4833.130036593412;4857.465678775332;4865.732384718839;4726;4737.123632128068;4744.976275118637;4748.19280722278;4784.330193772875;4702.153612349775;4736.786844592001;4738.644601654855;4754.453237877654;4765.951490672047;5032.823851165192;5098.923516147223;5136.126858434038;5224.63427560071;5256.50063243995;5664.631798933056;5672.461116193955;5688.943110568925;5693.743781529841;5732.140178973145;5722.456366645162;5736.426357364272;5738.68437235956;5740.1102829061565;5744.626599271034;5170.405403378584;5251.816186433456;5251.842444726664;5325.866853328659;5343.65266257692;5776.826695199151;5849.2103566018895;5858.853528661817;5859.44335288147;5887.4406931341455;5611.102223644198;5620.887582248414;5625.409332020161;5632.718364081779;5684.431556844283;5594.13290939905;5650.519705825051;5663.9716801415725;5666.773329066874;5706.115552089433;5529.281193444907;5641.294838145232;5763.164341170507;5763.538916886723;5781.797637082682;5616.213730077792;5648.491635752802;5659.066254068115;5666.886662266732;5669.06460434032;4358.128374325084;4376.803043863034;4387.451568553931;4396.120775844844;4419.469663640384;3818.6372294631965;3855.383138697795;3859.073822282688;3915.6084391561185;3969.861054863066;5261.657992230493;5278.5249327560705;5279.736013199325;5325.573954083664;5329.387120481194;5535.944640553543;5648.096304591328;5679.858003549944;5687.317521897398;5696.231008813757;5197.922031169535;5221.373435187726;5261.631685781958;5279.47205279469;5338.54622357104;4873.853784386474;4878.829240976549;4880.877978050577;4884.609231261491;4923.507649235119;5667.40492248308;5755.85610359736;5758.942410575841;5764.279465066867;5766.88466230673;5610.186522954067;5616.241807356118;5647;5653.745581448927;5716.3140423147825;5881.852953676193;5885.499732522612;5891.734871930687;5919.052951527735;5952.702364881652;5662.490375866192;5667.518260947701;5672.064109421899;5673.489385955284;5680.545556355399;5573.498385145194;5673.858153546194;5674.092145256739;5685.715714214355;5752.223449834219;5526.585506086979;5576.581756368208;5577.609567330248;5586.413426590149;5639.6334238274385;5493.395726470165;5500.202470641654;5502.367227768857;5505.614606977473;5516.503514683698;5289;5416.431274716256;5421.812437281933;5460.126379779216;5463.48096930791;5475.698836564027;5498.532624726943;5550.333959924674;5612.382637909908;5626.2685850839125;5467.152591348188;5510.366307874646;5511.779528818963;5520.06158952971;5526.364468086222 14:22:48 INFO - PROCESS | 17569 | |1;ext.html;532.9607265831627;539.9163129714894;555.3641080962299;562.9465200805922;585.3297973819973;27686.16941491756;28582.857085714542;28598.28504287391;28598.714012859866;28625.85687071567;28849;29422.705772942263;36844;37355.25289494209;37384;8473.322134229262;8601.225889669928;8608.053114157437;8619;8620.137986201393;5947.851303717398;5953.58324917256;5953.642781433128;5958.8808223835495;6171.907421388661;7626.771196864103;7812.960935195316;10123.08892199702;10341.948290258539;10344.844827327595;9980.351277166998;10080.798384032278;10084.64703735373;10087.49562521871;10099.646512372032;7559.206283340225;7742.419318551075;10105.797884042278;10235.846462303072;10261.846072308921;38984.41523377151;39377.40933885994;39491.802540987395;39646;39675.20649587021;3059.4147944986453;3243.4323993301314;3439.9656003439895;3893.4549163117185;3933.98033009836;26619.733802661918;27177.1846844595;27311.180664580093;27625.171244862486;27865.58201626977;3700.8149592520267;3730.235301763132;3744.719146064029;3790.8104594770425;3810.8475660973804;285223.5738821313;285695;285926;286713;286963;56778.716106419204;57564.71217643969;57678.4232157673;57681.42318576844;57691.423085768605;60111.699441503384;60432;60527.69736151379;60673.69663151656;60704.392956070755;13849.723005539832;13870.375833087535;13892.374843132084;13945.930270348787;13948.651283717989;11240.831387529193;11303;11303.208775385809;11310.491027903765;11316.094712422986;18211.163416274227;19021.524461888286;19076.71384929227;19178.13698383576;19191.712124318146;7201.17186523546;7357.190709022003;7417.666205020787;7456.7390141344795;7484.1393239777035;929.0802105915095;947.1286416496839;947.4552132523827;997.9850302245472;1001.8046480936148;30157.396852063273;31183.376332473224;31298.530522042187;31644.525332120036;31861.362772744415;959.5825815770162;969.1616751509894;1014.5586669798661;1064.43052966664;1065.5205157679075;13742.725145497034;14458.204798736171;14992.175430351217;15213.919223781686;15337.386504539916;298779;301214;301551;302394;303096;54271.72864135654;55384;55528.44471555314;56465;56667.71666141643;1389.6317475868902;1392.324722509582;1394.0381137015427;1394.8395934467667;1395.846456889721;27897.860510698127;28058.57912131279;29098.41803163967;29985.250368740955;31648;47773.76113119412;48783.268250975554;48865;48981;49002.75498622484;229194;233856;234359;234518;234624;42372;42743;42932.35601465918;43237.35143972906;43681.34477982769;45419.772901135286;45713.31430028486;45782;46423.53576464192;46734.53265467302;36866.44700329444;38647.2270554593;38813.805930970164;39029.6097039026;39645;34237.315253695284;35951;36944.07639809026;37424;39092;33350.666493335724;33833.66166338305;34246.657533424346;34295.31409371849;34352.141196470286;28725.56911646285;30847.537286941162;31440;31451.213719657193;31498.52752208673;24043.158489452784;24081.75918240795;24430.755692442846;25275.368115797253;25408 14:22:48 INFO - PROCESS | 17569 | |2;jquery.html;350.9017475106969;356.04934824019864;357.58162949349264;358.79010778694465;359.2778515184479;14172.433102675906;14456.494022709207;15795.526134215977;15824;16475.835241647565;15085.472008479677;15101.244937753123;15469.149196794171;15480.380784768597;15486.457973970913;5218.165093585008;5259.342582177237;5368.141097424413;5369.087255166612;5374.677519348832;3738.084169378506;3832.5400951885813;5272.841814745545;5278.498542638463;5376.8118115865955;5294.020606187848;5336.893262134755;5349.331333583302;5355;5363.758630861601;5297.023785808185;5972.134040564116;6035.396460353973;6039.516838652898;6045.576809623328;5341.626086173969;5373.811916582901;5376.516113549799;5378;5380.166074258496;13114.47542098315;13135.211887286794;13135.671608209776;13828.308584570832;15808.446704365291;2067.8759274443582;2079.189116244666;2122.310249169026;2187.5187458759206;2194.846360754732;9670.129688328014;9760.072793084646;9772.95113524435;12072.637820865388;12305.75388492234;1847.9260829566801;1850.8334249917436;1853.8887666740038;1862.9161687724086;1893.422506135628;55822.72088639571;56896.715516422155;58677;59266;60487.395126048614;10276.177905767521;10311.74220644475;10319.587216511405;10325.690229293134;10385.84421233682;13524.256165910772;13539.66150846217;13543.45826166962;13558.86441135576;13562.389692463863;6888.311168883071;6912.101426814482;6931.618760968196;6977.89533157003;6983.336583024605;6263.71813268404;6306.3378345274;6321.778737744249;6398.520110991694;6502.44729198014;4413.426254586883;4434.224010798098;4457.8439754608435;4482.417285752831;4531.342955271467;1735.3752649046585;1779.0926627419851;1784.4111443223705;1791.3551121596215;1839.705647096458;451.58003057156503;451.61612629265517;895.0512456795688;921.8386782313203;1002.7142264454595;9247.26021918245;10230.795384092426;10358.792824143475;10537.57849686004;10624;464.8930745928388;869.599984007351;892.312919052339;910.5401772105045;956.2875657635107;8535.97568291809;9192.724218273463;9209.76975575616;9245.214156796614;9296.209822165056;295682.5215873907;589288;593279;594915;603220;70743;72162;73355;74704;76034.61982690051;1091.5961094395125;1094.0645747885603;1095.0801326885296;1103.2497901426946;1104.0560320925654;13907.652308692364;14227.07524010936;14665.63335916568;15051.623709407353;15277.77083343773;20438.182472700926;27688.30779230455;31984.84007579947;32825.778328767636;33254;40407;41270.38094428526;41331.380029300184;42310.78844605757;42330.36504452374;9490;9653.9034609653;9718.173955213602;9955.452450115314;10008.349457285252;17529.474115776546;17717.114144292475;17852.91073544624;17938.461846144637;18027.639447211244;14491;14519.34662940149;14642.853571464575;14893.776593351326;15069.321880515623;14318.85681143217;14535.127892326494;14637;14839;14939.701205976036;11570.363630000431;12666.683332916751;14094.295285235903;14233.572992810232;14627.268636567916;9244.445333280024;9297.395669281475;9327.207187389147;9424.905750942402;9557.808843823224;13472.461101555828;13484.595462136152;13694.726105478034;13812;14172.362243699265 14:22:48 INFO - PROCESS | 17569 | |3;mootools.html;1275.502554003938;1477.630592351912;1485.3167542930248;1646.6871294454054;1780.4925596205085;6602.306757790435;7256.8911466328045;7360.411167106632;7377.299156580117;7380.077490313711;7169.82075448114;7282.708691652328;7338.669759860806;7357.705691772336;7358.779236622897;1965.555316842127;1999.8100180482904;2007.3576455534235;2210.933671989843;2249;2216.0803266644325;2251.5609456156058;2260.2089268755885;2262.3326118794994;2262.9660555091687;2155.385715071205;2181.792729690677;2228.810551103158;2232.3303009097285;2233.02863254484;2196.2532738868863;2233.3411643565105;2241.0363543676212;2260.547890421914;2261.705978222829;2210.6573481110295;2216.346177877514;2243.8317126215597;2244.382794731462;2250.3361508355074;7443.367313778335;7526.209747976438;7530.548167109936;7532.435067369969;7538.396928245727;4478.932816007762;4528.071745292207;4542.568455996675;4546.772661366918;4547.226971414867;2930.8241505509523;2953.616029916119;2972.65814431341;2974.107767669712;3089.891853785129;1033.8707661542308;1037.2376303416982;1038.1850247555633;1064.8935106489366;1078.051314842941;10283.948580257125;10310.278280520366;10311.742206444824;10335;10343.534540945675;4104.979475102606;4158.293090174678;4188.937165942513;4203.327467605169;4206.453161089039;8842.955785221162;8849.380543361904;8849.955750221336;8851.424657397249;8861.955690221508;4476.37330773692;4517.299818528133;4518.344839998247;4519.276915693474;4524.615407690318;4044.3326851069833;4071.328230841937;4075.3275709507598;4094.7133700641266;4101.774402407897;3313.4698448248164;3335.6831101045364;3504.369213541587;3534.6818786309354;3597.982010089933;1142.6743378137357;1143.1597775634903;1144.6508814811395;1152.8040233160382;1156.6876943225282;1003.0922015575916;1004.1966426858484;1073.8335557988523;1146.6388087752332;1345.3945724424048;6798.388145066968;6838.281980391987;6890.44876409886;6893.827654308582;6911.447084233249;1091.47063674118;1097.4238524774398;1113.8663360396804;1114.1031469666996;1119.160629527854;5191.506806853343;5265.104932161542;5266.8156614519075;5275.050490911673;5276.498732620472;8791.648334066565;8869.822603547893;8990.640374384951;9033.96109447422;9100.954495227481;8863.157999989991;8899.288056955427;8931.73204803857;8985.505797181218;8994.370394072483;6906.102206713095;7007.789766307019;7105.32499412555;7147.89278160828;7184.820379490555;6917.37743603058;6921.757738479129;6927.44580433554;6931.168259808654;6941.236463989058;7683.807904802425;7979.281864632211;8080.2727754502375;8083.19168083187;8095.23095305945;7940.880886786818;7951.324137448381;7953.085395179397;8055.436119471581;8076.71731489395;6606.405423511907;6615.503837212132;6683.164604424447;6685.832854178684;6786.524943253925;6487.967560162358;6594.967025164843;7014.719411223494;7078.1506219254015;7156.463265255231;6662.267150613526;6745.12313399255;6776.220734615582;6837.3162683731225;6905.482088843457;6564.704588293634;6611.768588099586;6670.299618539983;6675.699593518206;6693.598384096969;6675.532712710064;6711.261761206166;6711.530192886451;6716.059751634677;6719.496037797087;6040.546958978006;6282.654454005074;6326.177596912372;6329.050642403677;6332.30344662096;6312.43188113072;6335.588186767845;6356.713947872265;6367.61794292344;6371.713272902638 14:22:48 INFO - PROCESS | 17569 | |4;prototype.html;335.9596848378195;337.421322432029;339.07094560903124;344.69150110650986;347.90084825824636;5861.0915308127205;5881.588288819784;5883.029300165473;5895.322037965624;5917.053271476565;5618.803341883025;5655.604107712462;5744.33940096889;5816.447437493442;5839.036558967765;4503.842365517207;4516.616087632538;4521.253993091136;4528.003839155389;4541.636669066484;4360.847370342039;4531.43357080365;4537.9773101134615;4538.228501154812;4547.613452856511;4367.71609845359;4421.204183247014;4544.386507821435;4559.931601025987;4565.1098035883015;4515.367848501212;4521.706089104197;4523.6607254455885;4538.727676339414;4548.135854187693;4023.97988010061;4025.295573274665;4028.536718277377;4029;4034.8587799427173;5526.336839579236;5620.91568626471;5634.6337488063145;5635.21107045014;5683.886322273532;5298.125809241471;5308.203769434577;5310.283111779938;5311.468853114697;5311.548518375943;6224.62652240867;6228.065790131472;6233;6235.906461403082;6237.34507876671;4458.9554104459185;4459.241928872099;4460.442444694413;4462.263726485126;4464.441944756905;6335.208098987627;6509.576877502947;6512.967435162841;6518.28298887122;6520.11978382917;4560.429946256718;4572.3827283317;4577.084583083397;4577.29051996941;4578.88552786183;4624.630029597692;4624.722516648944;4631.560001799824;4634.83778067766;4636.79134438951;5251.448597897166;5280.075986702312;5284.4187139414635;5289.550388217045;5299.046171689133;6096.420840020191;6249.6562689052535;6252.343503932022;6267.9373206268265;6275.811725648238;1614.2251719174863;1639.4098124675345;1641.8029836419705;1643.786307779981;1643.9424620138238;1092.093562343253;1094;1102.8897110288906;1106.8893110688866;1148.8276758486295;5893.6463812171405;5895.35151133375;5907.409259074144;5912.852178695567;5914.615549989323;6420.711068001858;6428.100065990765;6428.903566446507;6433.806985790434;6436.742530298736;5775.33583637887;5839.649621022752;5906;5984.611000284967;5991.7902873399225;3471.8437670304897;3486.773359731609;3492.1444246159854;3496.440569508917;3500.3524347995703;6625.668716564152;6660.533762636569;6677.699503522354;6680.632565208863;6680.799576012728;6476.6114033158165;6675.399214070757;6683.7660681875905;6692.83267918306;6698.799036028927;6688.030235615905;6697.564658297195;6698.196216453959;6699.564528305645;6699.79900602973;6439.7424103035355;6479.254885688206;6494.415502604788;6496.675166241764;6501.902471463027;6318.557700961072;6391.9041214380895;6400.935990640221;6424.646644434414;6430.260520040255;6662.933370666231;6675.332466753286;6678.532502724763;6681.699323530355;6685.76599819004;4469.709468884512;4500.7524586146765;4505.7296562206375;4514.774261286988;4518.028623845889;6295.842603934938;6498.317676643885;6521.934780652133;6526.412622863965;6538.738450461929;6350.015747559136;6367.204099487564;6369;6373.171487706569;6374.904376434264;6330.588511746721;6332.145160403286;6336.809895703136;6345.555811093179;6352.0789485525265;6080.69596520181;6219;6228.439440450381;6230.43926046658;6234.064890266496;6357.554971151975;6367.745290188526;6372.044193371032;6375.075614036032;6386.648734319657;6218;6274.498040156868;6278.46633036197;6278.843028924313;6282.528810339151 14:22:48 INFO - PROCESS | 17569 | |5;yui.html;738.0331765387343;759.108048043549;813.1258896686064;839.1566475691928;844.4806444036917;13510.932445337772;13773.51792687256;13833.654158646039;13856.722865542682;13870.861291387084;12862.356882155878;12874.742505149892;12887.355632218398;12906.096573239876;12914.74170516589;675.5912672832939;794.9046114466272;804.7424824056304;804.8752443371287;806.2582424169777;681.0363335879724;794;822.6051495282268;825.471698113208;825.694493037577;857.2713193785295;857.9656813727444;864.5115509736978;865.074370423647;866.0689758509595;699.1016543741268;712.3304094151481;860.2129051917487;860.9969385665692;861.452977359375;620.7765204526366;631.8894193516117;633.9112524246609;634.4004915354991;634.5336177909234;13287.269200193985;13357.666058348523;13452.596422107352;13466.596002119952;13469.797953030713;11048.337099774039;11191.384473853936;11325.490352934137;11336.376499292535;12752.426140823685;10187.643432479828;10239.12967397772;10562.419066951315;10969.83545246822;10987.670369888836;3653.2328211075705;3720.1257704439436;3747.2505498900327;3757.981210093932;3821.159344944108;48106.518934810556;48764;48767.512324876654;49287.50712492865;49310.50689493095;9987.950060249652;10047.296689231684;10245.077942985166;10310.32982856127;10481.423521706227;17811.198496067707;17819.554511137325;17838.286468541373;17850.19674114668;17938.103094845468;7130.750423735144;7244.710211591478;7355;7357.5217610855125;7399.704011839466;4305.935410968838;4333.263345231318;4390.209762242827;4444.644428445781;4451.154280686659;3117.314190878003;3124.8594263093805;3131.0919833248104;3136.2316232523176;3141.8429078545983;555.5777609017176;561.264743186427;566.1309889319956;573.3692937768421;573.6672729816696;487.89754151628557;507.56603104345993;519.158962480776;534.9277847490539;598.4793229890023;7919.168487308865;8078.8788168177525;8109.229623185788;8192.795180120425;8360.56226293475;534.8475684429919;623.3486007122568;638.3297537585516;660.6729668813967;666.73997141115;3775.8867233982473;3959.9437981898;4019.457373254632;4074.0629655179473;4333.761643109596;56753.43246567564;56914.43085569174;57040.71479642658;60079;60372;50255;51484.74257628688;51580.74209628928;51697.48302516927;51831.22253166205;48261.27608085952;48686.5131348689;48757.75621121943;49127.75436122796;50400.49599504031;8311.418200725891;8314.16858314188;8415.200555947175;8455.8731619027;8788.780280493038;35871.46192807058;36241.27517449584;36391.818040909624;37347.626523735504;37354.44806707046;42957.14085718331;43040.354394683476;45551.31673024841;47936.28095578499;48401.5159848397;10062.855372685475;10315.896841031494;10352.482375881327;10548.972044379307;10860.239783215098;11350.205485615928;11723.941380293043;11872.821907671565;11934.641960741192;11941.223820451643;10623.89376106229;10801.945990269998;11055.889441105808;11126.109911207246;11275.267107637977;10620.415877126523;11076.556937722724;11175.944120279346;11316.717082072684;11483.48324325424;10243.129334006395;10248.487575621339;10713.196510261918;10730.517126729159;10782.73043173927;8982.416142950688;8994.235489983163;9215.631374744935;9345.345825792128;9362;8702.825943480968;8706.521141337287;8765.254953328784;9149.908500914906;9342.486163261086 14:22:48 INFO - PROCESS | 17569 | __end_tp_report 14:22:48 INFO - PROCESS | 17569 | __start_cc_report 14:22:48 INFO - PROCESS | 17569 | _x_x_mozilla_cycle_collect,912 14:22:48 INFO - PROCESS | 17569 | __end_cc_report 14:22:48 INFO - PROCESS | 17569 | __startTimestamp1451600568541__endTimestamp 14:22:48 INFO - PROCESS | 17569 | 14:22:48 INFO - PROCESS | 17569 | ------- Summary: start ------- 14:22:48 INFO - PROCESS | 17569 | Number of tests: 6 14:22:48 INFO - PROCESS | 17569 | 14:22:48 INFO - PROCESS | 17569 | [#0] dojo.html Cycles:165 Average:5258.79 Median:5493.40 stddev:587.74 (10.7%) stddev-sans-first:564.87 14:22:48 INFO - PROCESS | 17569 | Values: 3110.8 3140.7 3174.3 3178.4 3211.1 5042.3 5222.4 5234.9 5240.2 5286.4 5191.6 5196.0 5231.6 5234.5 5312.3 4774.3 4796.3 4844.8 4904.2 4919.0 4853.9 4854.7 4931.2 4934.4 4935.6 4748.8 4750.6 4833.1 4857.5 4865.7 4726.0 4737.1 4745.0 4748.2 4784.3 4702.2 4736.8 4738.6 4754.5 4766.0 5032.8 5098.9 5136.1 5224.6 5256.5 5664.6 5672.5 5688.9 5693.7 5732.1 5722.5 5736.4 5738.7 5740.1 5744.6 5170.4 5251.8 5251.8 5325.9 5343.7 5776.8 5849.2 5858.9 5859.4 5887.4 5611.1 5620.9 5625.4 5632.7 5684.4 5594.1 5650.5 5664.0 5666.8 5706.1 5529.3 5641.3 5763.2 5763.5 5781.8 5616.2 5648.5 5659.1 5666.9 5669.1 4358.1 4376.8 4387.5 4396.1 4419.5 3818.6 3855.4 3859.1 3915.6 3969.9 5261.7 5278.5 5279.7 5325.6 5329.4 5535.9 5648.1 5679.9 5687.3 5696.2 5197.9 5221.4 5261.6 5279.5 5338.5 4873.9 4878.8 4880.9 4884.6 4923.5 5667.4 5755.9 5758.9 5764.3 5766.9 5610.2 5616.2 5647.0 5653.7 5716.3 5881.9 5885.5 5891.7 5919.1 5952.7 5662.5 5667.5 5672.1 5673.5 5680.5 5573.5 5673.9 5674.1 5685.7 5752.2 5526.6 5576.6 5577.6 5586.4 5639.6 5493.4 5500.2 5502.4 5505.6 5516.5 5289.0 5416.4 5421.8 5460.1 5463.5 5475.7 5498.5 5550.3 5612.4 5626.3 5467.2 5510.4 5511.8 5520.1 5526.4 14:22:48 INFO - PROCESS | 17569 | 14:22:48 INFO - PROCESS | 17569 | [#1] ext.html Cycles:180 Average:44643.89 Median:34241.99 stddev:71853.12 (209.8%) stddev-sans-first:71978.35 14:22:48 INFO - PROCESS | 17569 | Values: 533.0 539.9 555.4 562.9 585.3 27686.2 28582.9 28598.3 28598.7 28625.9 28849.0 29422.7 36844.0 37355.3 37384.0 8473.3 8601.2 8608.1 8619.0 8620.1 5947.9 5953.6 5953.6 5958.9 6171.9 7626.8 7813.0 10123.1 10341.9 10344.8 9980.4 10080.8 10084.6 10087.5 10099.6 7559.2 7742.4 10105.8 10235.8 10261.8 38984.4 39377.4 39491.8 39646.0 39675.2 3059.4 3243.4 3440.0 3893.5 3934.0 26619.7 27177.2 27311.2 27625.2 27865.6 3700.8 3730.2 3744.7 3790.8 3810.8 285223.6 285695.0 285926.0 286713.0 286963.0 56778.7 57564.7 57678.4 57681.4 57691.4 60111.7 60432.0 60527.7 60673.7 60704.4 13849.7 13870.4 13892.4 13945.9 13948.7 11240.8 11303.0 11303.2 11310.5 11316.1 18211.2 19021.5 19076.7 19178.1 19191.7 7201.2 7357.2 7417.7 7456.7 7484.1 929.1 947.1 947.5 998.0 1001.8 30157.4 31183.4 31298.5 31644.5 31861.4 959.6 969.2 1014.6 1064.4 1065.5 13742.7 14458.2 14992.2 15213.9 15337.4 298779.0 301214.0 301551.0 302394.0 303096.0 54271.7 55384.0 55528.4 56465.0 56667.7 1389.6 1392.3 1394.0 1394.8 1395.8 27897.9 28058.6 29098.4 29985.3 31648.0 47773.8 48783.3 48865.0 48981.0 49002.8 229194.0 233856.0 234359.0 234518.0 234624.0 42372.0 42743.0 42932.4 43237.4 43681.3 45419.8 45713.3 45782.0 46423.5 46734.5 36866.4 38647.2 38813.8 39029.6 39645.0 34237.3 35951.0 36944.1 37424.0 39092.0 33350.7 33833.7 34246.7 34295.3 34352.1 28725.6 30847.5 31440.0 31451.2 31498.5 24043.2 24081.8 24430.8 25275.4 25408.0 14:22:48 INFO - PROCESS | 17569 | 14:22:48 INFO - PROCESS | 17569 | [#2] jquery.html Cycles:180 Average:27703.04 Median:356.82 stddev:89644.08 (25123.4%) stddev-sans-first:89872.02 14:22:48 INFO - PROCESS | 17569 | Values: 350.9 356.0 357.6 358.8 359.3 14172.4 14456.5 15795.5 15824.0 16475.8 15085.5 15101.2 15469.1 15480.4 15486.5 5218.2 5259.3 5368.1 5369.1 5374.7 3738.1 3832.5 5272.8 5278.5 5376.8 5294.0 5336.9 5349.3 5355.0 5363.8 5297.0 5972.1 6035.4 6039.5 6045.6 5341.6 5373.8 5376.5 5378.0 5380.2 13114.5 13135.2 13135.7 13828.3 15808.4 2067.9 2079.2 2122.3 2187.5 2194.8 9670.1 9760.1 9773.0 12072.6 12305.8 1847.9 1850.8 1853.9 1862.9 1893.4 55822.7 56896.7 58677.0 59266.0 60487.4 10276.2 10311.7 10319.6 10325.7 10385.8 13524.3 13539.7 13543.5 13558.9 13562.4 6888.3 6912.1 6931.6 6977.9 6983.3 6263.7 6306.3 6321.8 6398.5 6502.4 4413.4 4434.2 4457.8 4482.4 4531.3 1735.4 1779.1 1784.4 1791.4 1839.7 451.6 451.6 895.1 921.8 1002.7 9247.3 10230.8 10358.8 10537.6 10624.0 464.9 869.6 892.3 910.5 956.3 8536.0 9192.7 9209.8 9245.2 9296.2 295682.5 589288.0 593279.0 594915.0 603220.0 70743.0 72162.0 73355.0 74704.0 76034.6 1091.6 1094.1 1095.1 1103.2 1104.1 13907.7 14227.1 14665.6 15051.6 15277.8 20438.2 27688.3 31984.8 32825.8 33254.0 40407.0 41270.4 41331.4 42310.8 42330.4 9490.0 9653.9 9718.2 9955.5 10008.3 17529.5 17717.1 17852.9 17938.5 18027.6 14491.0 14519.3 14642.9 14893.8 15069.3 14318.9 14535.1 14637.0 14839.0 14939.7 11570.4 12666.7 14094.3 14233.6 14627.3 9244.4 9297.4 9327.2 9424.9 9557.8 13472.5 13484.6 13694.7 13812.0 14172.4 14:22:48 INFO - PROCESS | 17569 | 14:22:48 INFO - PROCESS | 17569 | [#3] mootools.html Cycles:180 Average:5226.63 Median:6161.60 stddev:2681.31 (43.5%) stddev-sans-first:2672.38 14:22:48 INFO - PROCESS | 17569 | Values: 1275.5 1477.6 1485.3 1646.7 1780.5 6602.3 7256.9 7360.4 7377.3 7380.1 7169.8 7282.7 7338.7 7357.7 7358.8 1965.6 1999.8 2007.4 2210.9 2249.0 2216.1 2251.6 2260.2 2262.3 2263.0 2155.4 2181.8 2228.8 2232.3 2233.0 2196.3 2233.3 2241.0 2260.5 2261.7 2210.7 2216.3 2243.8 2244.4 2250.3 7443.4 7526.2 7530.5 7532.4 7538.4 4478.9 4528.1 4542.6 4546.8 4547.2 2930.8 2953.6 2972.7 2974.1 3089.9 1033.9 1037.2 1038.2 1064.9 1078.1 10283.9 10310.3 10311.7 10335.0 10343.5 4105.0 4158.3 4188.9 4203.3 4206.5 8843.0 8849.4 8850.0 8851.4 8862.0 4476.4 4517.3 4518.3 4519.3 4524.6 4044.3 4071.3 4075.3 4094.7 4101.8 3313.5 3335.7 3504.4 3534.7 3598.0 1142.7 1143.2 1144.7 1152.8 1156.7 1003.1 1004.2 1073.8 1146.6 1345.4 6798.4 6838.3 6890.4 6893.8 6911.4 1091.5 1097.4 1113.9 1114.1 1119.2 5191.5 5265.1 5266.8 5275.1 5276.5 8791.6 8869.8 8990.6 9034.0 9101.0 8863.2 8899.3 8931.7 8985.5 8994.4 6906.1 7007.8 7105.3 7147.9 7184.8 6917.4 6921.8 6927.4 6931.2 6941.2 7683.8 7979.3 8080.3 8083.2 8095.2 7940.9 7951.3 7953.1 8055.4 8076.7 6606.4 6615.5 6683.2 6685.8 6786.5 6488.0 6595.0 7014.7 7078.2 7156.5 6662.3 6745.1 6776.2 6837.3 6905.5 6564.7 6611.8 6670.3 6675.7 6693.6 6675.5 6711.3 6711.5 6716.1 6719.5 6040.5 6282.7 6326.2 6329.1 6332.3 6312.4 6335.6 6356.7 6367.6 6371.7 14:22:48 INFO - PROCESS | 17569 | 14:22:48 INFO - PROCESS | 17569 | [#4] prototype.html Cycles:180 Average:5261.16 Median:5894.48 stddev:1564.71 (26.5%) stddev-sans-first:1524.81 14:22:48 INFO - PROCESS | 17569 | Values: 336.0 337.4 339.1 344.7 347.9 5861.1 5881.6 5883.0 5895.3 5917.1 5618.8 5655.6 5744.3 5816.4 5839.0 4503.8 4516.6 4521.3 4528.0 4541.6 4360.8 4531.4 4538.0 4538.2 4547.6 4367.7 4421.2 4544.4 4559.9 4565.1 4515.4 4521.7 4523.7 4538.7 4548.1 4024.0 4025.3 4028.5 4029.0 4034.9 5526.3 5620.9 5634.6 5635.2 5683.9 5298.1 5308.2 5310.3 5311.5 5311.5 6224.6 6228.1 6233.0 6235.9 6237.3 4459.0 4459.2 4460.4 4462.3 4464.4 6335.2 6509.6 6513.0 6518.3 6520.1 4560.4 4572.4 4577.1 4577.3 4578.9 4624.6 4624.7 4631.6 4634.8 4636.8 5251.4 5280.1 5284.4 5289.6 5299.0 6096.4 6249.7 6252.3 6267.9 6275.8 1614.2 1639.4 1641.8 1643.8 1643.9 1092.1 1094.0 1102.9 1106.9 1148.8 5893.6 5895.4 5907.4 5912.9 5914.6 6420.7 6428.1 6428.9 6433.8 6436.7 5775.3 5839.6 5906.0 5984.6 5991.8 3471.8 3486.8 3492.1 3496.4 3500.4 6625.7 6660.5 6677.7 6680.6 6680.8 6476.6 6675.4 6683.8 6692.8 6698.8 6688.0 6697.6 6698.2 6699.6 6699.8 6439.7 6479.3 6494.4 6496.7 6501.9 6318.6 6391.9 6400.9 6424.6 6430.3 6662.9 6675.3 6678.5 6681.7 6685.8 4469.7 4500.8 4505.7 4514.8 4518.0 6295.8 6498.3 6521.9 6526.4 6538.7 6350.0 6367.2 6369.0 6373.2 6374.9 6330.6 6332.1 6336.8 6345.6 6352.1 6080.7 6219.0 6228.4 6230.4 6234.1 6357.6 6367.7 6372.0 6375.1 6386.6 6218.0 6274.5 6278.5 6278.8 6282.5 14:22:48 INFO - PROCESS | 17569 | 14:22:48 INFO - PROCESS | 17569 | [#5] yui.html Cycles:180 Average:13846.64 Median:48544.01 stddev:16354.02 (33.7%) stddev-sans-first:16370.27 14:22:48 INFO - PROCESS | 17569 | Values: 738.0 759.1 813.1 839.2 844.5 13510.9 13773.5 13833.7 13856.7 13870.9 12862.4 12874.7 12887.4 12906.1 12914.7 675.6 794.9 804.7 804.9 806.3 681.0 794.0 822.6 825.5 825.7 857.3 858.0 864.5 865.1 866.1 699.1 712.3 860.2 861.0 861.5 620.8 631.9 633.9 634.4 634.5 13287.3 13357.7 13452.6 13466.6 13469.8 11048.3 11191.4 11325.5 11336.4 12752.4 10187.6 10239.1 10562.4 10969.8 10987.7 3653.2 3720.1 3747.3 3758.0 3821.2 48106.5 48764.0 48767.5 49287.5 49310.5 9988.0 10047.3 10245.1 10310.3 10481.4 17811.2 17819.6 17838.3 17850.2 17938.1 7130.8 7244.7 7355.0 7357.5 7399.7 4305.9 4333.3 4390.2 4444.6 4451.2 3117.3 3124.9 3131.1 3136.2 3141.8 555.6 561.3 566.1 573.4 573.7 487.9 507.6 519.2 534.9 598.5 7919.2 8078.9 8109.2 8192.8 8360.6 534.8 623.3 638.3 660.7 666.7 3775.9 3959.9 4019.5 4074.1 4333.8 56753.4 56914.4 57040.7 60079.0 60372.0 50255.0 51484.7 51580.7 51697.5 51831.2 48261.3 48686.5 48757.8 49127.8 50400.5 8311.4 8314.2 8415.2 8455.9 8788.8 35871.5 36241.3 36391.8 37347.6 37354.4 42957.1 43040.4 45551.3 47936.3 48401.5 10062.9 10315.9 10352.5 10549.0 10860.2 11350.2 11723.9 11872.8 11934.6 11941.2 10623.9 10801.9 11055.9 11126.1 11275.3 10620.4 11076.6 11175.9 11316.7 11483.5 10243.1 10248.5 10713.2 10730.5 10782.7 8982.4 8994.2 9215.6 9345.3 9362.0 8702.8 8706.5 8765.3 9149.9 9342.5 14:22:48 INFO - PROCESS | 17569 | -------- Summary: end -------- 14:22:48 INFO - PROCESS | 17569 | 14:22:49 INFO - TEST-INFO | 17569: exit 0 14:22:49 INFO - TEST-OK | dromaeo_css | took 1115976ms 14:22:49 INFO - TEST-START | kraken 14:22:49 INFO - operating with platform_type : linux_ 14:22:49 INFO - Initialising browser for kraken test... 14:22:49 INFO - TEST-INFO | started process 17761 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmplaLo0k/profile http://localhost:53406/getInfo.html) 14:22:54 INFO - PROCESS | 17761 | __metrics Screen width/height:1600/1200 14:22:54 INFO - PROCESS | 17761 | colorDepth:24 14:22:54 INFO - PROCESS | 17761 | Browser inner width/height: 1024/697 14:22:54 INFO - PROCESS | 17761 | __metrics 14:22:54 INFO - PROCESS | 17761 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:22:54 INFO - PROCESS | 17761 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:22:55 INFO - TEST-INFO | 17761: exit 0 14:22:55 INFO - Browser initialized. 14:22:55 INFO - Running cycle 1/1 for kraken test... 14:22:55 INFO - TEST-INFO | started process 17841 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmplaLo0k/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:23:07 INFO - PROCESS | 17841 | RSS: Main: 149819392 14:23:07 INFO - PROCESS | 17841 | 14:23:09 INFO - PROCESS | 17841 | Cycle 1(1): loaded http://localhost:53406/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53406/tests/kraken/driver.html?testName=audio-beat-detection) 14:23:10 INFO - PROCESS | 17841 | RSS: Main: 185208832 14:23:10 INFO - PROCESS | 17841 | 14:23:12 INFO - PROCESS | 17841 | Cycle 1(1): loaded http://localhost:53406/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53406/tests/kraken/driver.html?testName=audio-dft) 14:23:13 INFO - PROCESS | 17841 | RSS: Main: 174362624 14:23:13 INFO - PROCESS | 17841 | 14:23:16 INFO - PROCESS | 17841 | Cycle 1(1): loaded http://localhost:53406/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53406/tests/kraken/driver.html?testName=audio-fft) 14:23:17 INFO - PROCESS | 17841 | RSS: Main: 159776768 14:23:17 INFO - PROCESS | 17841 | 14:23:19 INFO - PROCESS | 17841 | Cycle 1(1): loaded http://localhost:53406/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53406/tests/kraken/driver.html?testName=audio-oscillator) 14:23:19 INFO - PROCESS | 17841 | RSS: Main: 161689600 14:23:19 INFO - PROCESS | 17841 | 14:23:21 INFO - PROCESS | 17841 | Cycle 1(1): loaded http://localhost:53406/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53406/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:23:22 INFO - PROCESS | 17841 | RSS: Main: 165720064 14:23:22 INFO - PROCESS | 17841 | 14:23:25 INFO - PROCESS | 17841 | Cycle 1(1): loaded http://localhost:53406/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53406/tests/kraken/driver.html?testName=imaging-darkroom) 14:23:25 INFO - PROCESS | 17841 | RSS: Main: 164835328 14:23:25 INFO - PROCESS | 17841 | 14:23:29 INFO - PROCESS | 17841 | Cycle 1(1): loaded http://localhost:53406/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53406/tests/kraken/driver.html?testName=imaging-desaturate) 14:23:29 INFO - PROCESS | 17841 | RSS: Main: 165998592 14:23:29 INFO - PROCESS | 17841 | 14:23:32 INFO - PROCESS | 17841 | Cycle 1(1): loaded http://localhost:53406/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53406/tests/kraken/driver.html?testName=json-parse-financial) 14:23:33 INFO - PROCESS | 17841 | RSS: Main: 164548608 14:23:33 INFO - PROCESS | 17841 | 14:23:34 INFO - PROCESS | 17841 | Cycle 1(1): loaded http://localhost:53406/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53406/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:23:35 INFO - PROCESS | 17841 | RSS: Main: 176582656 14:23:35 INFO - PROCESS | 17841 | 14:23:36 INFO - PROCESS | 17841 | Cycle 1(1): loaded http://localhost:53406/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53406/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:23:37 INFO - PROCESS | 17841 | RSS: Main: 174149632 14:23:37 INFO - PROCESS | 17841 | 14:23:39 INFO - PROCESS | 17841 | Cycle 1(1): loaded http://localhost:53406/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53406/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:23:40 INFO - PROCESS | 17841 | RSS: Main: 185233408 14:23:40 INFO - PROCESS | 17841 | 14:23:42 INFO - PROCESS | 17841 | Cycle 1(1): loaded http://localhost:53406/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53406/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:23:43 INFO - PROCESS | 17841 | RSS: Main: 194076672 14:23:43 INFO - PROCESS | 17841 | 14:23:45 INFO - PROCESS | 17841 | Cycle 1(1): loaded http://localhost:53406/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53406/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:23:46 INFO - PROCESS | 17841 | RSS: Main: 192172032 14:23:46 INFO - PROCESS | 17841 | 14:23:48 INFO - PROCESS | 17841 | Cycle 1(1): loaded http://localhost:53406/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53406/tests/kraken/driver.html?testName=ai-astar) 14:23:48 INFO - PROCESS | 17841 | RSS: Main: 251924480 14:23:48 INFO - PROCESS | 17841 | 14:23:48 INFO - PROCESS | 17841 | __start_tp_report 14:23:48 INFO - PROCESS | 17841 | _x_x_mozilla_page_load 14:23:48 INFO - PROCESS | 17841 | _x_x_mozilla_page_load_details 14:23:48 INFO - PROCESS | 17841 | |i|pagename|runs| 14:23:48 INFO - PROCESS | 17841 | |0;ai-astar;110;110;105;111;111;111;99;110;110;100 14:23:48 INFO - PROCESS | 17841 | |1;audio-beat-detection;151;124;145;167;126;149;152;123;175;126 14:23:48 INFO - PROCESS | 17841 | |2;audio-dft;161;160;160;161;162;162;161;163;163;162 14:23:48 INFO - PROCESS | 17841 | |3;audio-fft;72;72;83;95;71;72;72;96;91;71 14:23:48 INFO - PROCESS | 17841 | |4;audio-oscillator;96;96;143;95;95;96;138;96;96;141 14:23:48 INFO - PROCESS | 17841 | |5;imaging-gaussian-blur;109;108;109;109;109;109;109;109;109;109 14:23:48 INFO - PROCESS | 17841 | |6;imaging-darkroom;145;146;145;145;146;145;145;146;145;144 14:23:48 INFO - PROCESS | 17841 | |7;imaging-desaturate;96;96;95;96;97;95;96;96;96;95 14:23:48 INFO - PROCESS | 17841 | |8;json-parse-financial;57;58;61;58;61;58;60;66;56;56 14:23:48 INFO - PROCESS | 17841 | |9;json-stringify-tinderbox;67;69;68;69;69;69;69;69;68;69 14:23:48 INFO - PROCESS | 17841 | |10;stanford-crypto-aes;87;89;88;93;88;87;89;87;88;88 14:23:48 INFO - PROCESS | 17841 | |11;stanford-crypto-ccm;116;135;118;119;134;123;124;114;116;120 14:23:48 INFO - PROCESS | 17841 | |12;stanford-crypto-pbkdf2;140;143;150;151;167;140;154;140;149;138 14:23:48 INFO - PROCESS | 17841 | |13;stanford-crypto-sha256-iterative;68;67;66;67;67;68;67;66;67;68 14:23:48 INFO - PROCESS | 17841 | __end_tp_report 14:23:48 INFO - PROCESS | 17841 | __start_cc_report 14:23:48 INFO - PROCESS | 17841 | _x_x_mozilla_cycle_collect,921 14:23:48 INFO - PROCESS | 17841 | __end_cc_report 14:23:48 INFO - PROCESS | 17841 | __startTimestamp1451600628324__endTimestamp 14:23:48 INFO - PROCESS | 17841 | 14:23:48 INFO - PROCESS | 17841 | ------- Summary: start ------- 14:23:48 INFO - PROCESS | 17841 | Number of tests: 14 14:23:48 INFO - PROCESS | 17841 | 14:23:48 INFO - PROCESS | 17841 | [#0] ai-astar Cycles:10 Average:107.70 Median:110.50 stddev:4.67 (4.2%) stddev-sans-first:4.88 14:23:48 INFO - PROCESS | 17841 | Values: 110.0 110.0 105.0 111.0 111.0 111.0 99.0 110.0 110.0 100.0 14:23:48 INFO - PROCESS | 17841 | 14:23:48 INFO - PROCESS | 17841 | [#1] audio-beat-detection Cycles:10 Average:143.80 Median:150.00 stddev:18.61 (12.4%) stddev-sans-first:19.56 14:23:48 INFO - PROCESS | 17841 | Values: 151.0 124.0 145.0 167.0 126.0 149.0 152.0 123.0 175.0 126.0 14:23:48 INFO - PROCESS | 17841 | 14:23:48 INFO - PROCESS | 17841 | [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:1.08 (0.7%) stddev-sans-first:1.13 14:23:48 INFO - PROCESS | 17841 | Values: 161.0 160.0 160.0 161.0 162.0 162.0 161.0 163.0 163.0 162.0 14:23:48 INFO - PROCESS | 17841 | 14:23:48 INFO - PROCESS | 17841 | [#3] audio-fft Cycles:10 Average:79.50 Median:77.50 stddev:10.68 (13.8%) stddev-sans-first:10.98 14:23:48 INFO - PROCESS | 17841 | Values: 72.0 72.0 83.0 95.0 71.0 72.0 72.0 96.0 91.0 71.0 14:23:48 INFO - PROCESS | 17841 | 14:23:48 INFO - PROCESS | 17841 | [#4] audio-oscillator Cycles:10 Average:109.20 Median:96.00 stddev:21.75 (22.7%) stddev-sans-first:22.54 14:23:48 INFO - PROCESS | 17841 | Values: 96.0 96.0 143.0 95.0 95.0 96.0 138.0 96.0 96.0 141.0 14:23:48 INFO - PROCESS | 17841 | 14:23:48 INFO - PROCESS | 17841 | [#5] imaging-gaussian-blur Cycles:10 Average:108.90 Median:109.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 14:23:48 INFO - PROCESS | 17841 | Values: 109.0 108.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 14:23:48 INFO - PROCESS | 17841 | 14:23:48 INFO - PROCESS | 17841 | [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 14:23:48 INFO - PROCESS | 17841 | Values: 145.0 146.0 145.0 145.0 146.0 145.0 145.0 146.0 145.0 144.0 14:23:48 INFO - PROCESS | 17841 | 14:23:48 INFO - PROCESS | 17841 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 14:23:48 INFO - PROCESS | 17841 | Values: 96.0 96.0 95.0 96.0 97.0 95.0 96.0 96.0 96.0 95.0 14:23:48 INFO - PROCESS | 17841 | 14:23:48 INFO - PROCESS | 17841 | [#8] json-parse-financial Cycles:10 Average:59.10 Median:59.00 stddev:3.03 (5.1%) stddev-sans-first:3.12 14:23:48 INFO - PROCESS | 17841 | Values: 57.0 58.0 61.0 58.0 61.0 58.0 60.0 66.0 56.0 56.0 14:23:48 INFO - PROCESS | 17841 | 14:23:48 INFO - PROCESS | 17841 | [#9] json-stringify-tinderbox Cycles:10 Average:68.60 Median:69.00 stddev:0.70 (1.0%) stddev-sans-first:0.44 14:23:48 INFO - PROCESS | 17841 | Values: 67.0 69.0 68.0 69.0 69.0 69.0 69.0 69.0 68.0 69.0 14:23:48 INFO - PROCESS | 17841 | 14:23:48 INFO - PROCESS | 17841 | [#10] stanford-crypto-aes Cycles:10 Average:88.40 Median:88.00 stddev:1.78 (2.0%) stddev-sans-first:1.81 14:23:48 INFO - PROCESS | 17841 | Values: 87.0 89.0 88.0 93.0 88.0 87.0 89.0 87.0 88.0 88.0 14:23:48 INFO - PROCESS | 17841 | 14:23:48 INFO - PROCESS | 17841 | [#11] stanford-crypto-ccm Cycles:10 Average:121.90 Median:121.50 stddev:7.32 (6.0%) stddev-sans-first:7.45 14:23:48 INFO - PROCESS | 17841 | Values: 116.0 135.0 118.0 119.0 134.0 123.0 124.0 114.0 116.0 120.0 14:23:48 INFO - PROCESS | 17841 | 14:23:48 INFO - PROCESS | 17841 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.20 Median:149.50 stddev:8.95 (6.0%) stddev-sans-first:9.11 14:23:48 INFO - PROCESS | 17841 | Values: 140.0 143.0 150.0 151.0 167.0 140.0 154.0 140.0 149.0 138.0 14:23:48 INFO - PROCESS | 17841 | 14:23:48 INFO - PROCESS | 17841 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.00 stddev:0.74 (1.1%) stddev-sans-first:0.71 14:23:48 INFO - PROCESS | 17841 | Values: 68.0 67.0 66.0 67.0 67.0 68.0 67.0 66.0 67.0 68.0 14:23:48 INFO - PROCESS | 17841 | -------- Summary: end -------- 14:23:48 INFO - PROCESS | 17841 | 14:23:49 INFO - TEST-INFO | 17841: exit 0 14:23:49 INFO - TEST-OK | kraken | took 60222ms 14:23:49 INFO - TEST-START | v8_7 14:23:49 INFO - operating with platform_type : linux_ 14:23:49 INFO - Initialising browser for v8_7 test... 14:23:49 INFO - TEST-INFO | started process 18090 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMhuoWH/profile http://localhost:53406/getInfo.html) 14:23:54 INFO - PROCESS | 18090 | __metrics Screen width/height:1600/1200 14:23:54 INFO - PROCESS | 18090 | colorDepth:24 14:23:54 INFO - PROCESS | 18090 | Browser inner width/height: 1024/697 14:23:54 INFO - PROCESS | 18090 | __metrics 14:23:54 INFO - PROCESS | 18090 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:23:54 INFO - PROCESS | 18090 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:23:55 INFO - TEST-INFO | 18090: exit 0 14:23:55 INFO - Browser initialized. 14:23:55 INFO - Running cycle 1/1 for v8_7 test... 14:23:55 INFO - TEST-INFO | started process 18175 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMhuoWH/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:24:07 INFO - PROCESS | 18175 | RSS: Main: 150319104 14:24:07 INFO - PROCESS | 18175 | 14:24:29 INFO - PROCESS | 18175 | Cycle 1(1): loaded http://localhost:53406/tests/v8_7/run.html (next: http://localhost:53406/tests/v8_7/run.html) 14:24:29 INFO - PROCESS | 18175 | RSS: Main: 577527808 14:24:29 INFO - PROCESS | 18175 | 14:24:29 INFO - PROCESS | 18175 | __start_tp_report 14:24:29 INFO - PROCESS | 18175 | _x_x_mozilla_page_load 14:24:29 INFO - PROCESS | 18175 | _x_x_mozilla_page_load_details 14:24:29 INFO - PROCESS | 18175 | |i|pagename|runs| 14:24:29 INFO - PROCESS | 18175 | |0;Richards;168.54879487611663 14:24:29 INFO - PROCESS | 18175 | |1;DeltaBlue;191.79133103183736 14:24:29 INFO - PROCESS | 18175 | |2;Encrypt;280.42624789680315 14:24:29 INFO - PROCESS | 18175 | |3;Decrypt;5256.544502617801 14:24:29 INFO - PROCESS | 18175 | |4;RayTrace;1962.7450980392157 14:24:29 INFO - PROCESS | 18175 | |5;Earley;811.0300081103001 14:24:29 INFO - PROCESS | 18175 | |6;Boyer;11928.57142857143 14:24:29 INFO - PROCESS | 18175 | |7;RegExp;25575 14:24:29 INFO - PROCESS | 18175 | |8;Splay;600.6006006006006 14:24:29 INFO - PROCESS | 18175 | |9;NavierStokes;4835.748792270531 14:24:29 INFO - PROCESS | 18175 | __end_tp_report 14:24:29 INFO - PROCESS | 18175 | __startTimestamp1451600669353__endTimestamp 14:24:29 INFO - PROCESS | 18175 | 14:24:29 INFO - PROCESS | 18175 | ------- Summary: start ------- 14:24:29 INFO - PROCESS | 18175 | Number of tests: 10 14:24:29 INFO - PROCESS | 18175 | 14:24:29 INFO - PROCESS | 18175 | [#0] Richards Cycles:1 Average:168.55 Median:168.55 stddev:0.00 (0.0%) 14:24:29 INFO - PROCESS | 18175 | Values: 168.5 14:24:29 INFO - PROCESS | 18175 | 14:24:29 INFO - PROCESS | 18175 | [#1] DeltaBlue Cycles:1 Average:191.79 Median:191.79 stddev:0.00 (0.0%) 14:24:29 INFO - PROCESS | 18175 | Values: 191.8 14:24:29 INFO - PROCESS | 18175 | 14:24:29 INFO - PROCESS | 18175 | [#2] Encrypt Cycles:1 Average:280.43 Median:280.43 stddev:0.00 (0.0%) 14:24:29 INFO - PROCESS | 18175 | Values: 280.4 14:24:29 INFO - PROCESS | 18175 | 14:24:29 INFO - PROCESS | 18175 | [#3] Decrypt Cycles:1 Average:5256.54 Median:5256.54 stddev:0.00 (0.0%) 14:24:29 INFO - PROCESS | 18175 | Values: 5256.5 14:24:29 INFO - PROCESS | 18175 | 14:24:29 INFO - PROCESS | 18175 | [#4] RayTrace Cycles:1 Average:1962.75 Median:1962.75 stddev:0.00 (0.0%) 14:24:29 INFO - PROCESS | 18175 | Values: 1962.7 14:24:29 INFO - PROCESS | 18175 | 14:24:29 INFO - PROCESS | 18175 | [#5] Earley Cycles:1 Average:811.03 Median:811.03 stddev:0.00 (0.0%) 14:24:29 INFO - PROCESS | 18175 | Values: 811.0 14:24:29 INFO - PROCESS | 18175 | 14:24:29 INFO - PROCESS | 18175 | [#6] Boyer Cycles:1 Average:11928.57 Median:11928.57 stddev:0.00 (0.0%) 14:24:29 INFO - PROCESS | 18175 | Values: 11928.6 14:24:29 INFO - PROCESS | 18175 | 14:24:29 INFO - PROCESS | 18175 | [#7] RegExp Cycles:1 Average:25575.00 Median:25575.00 stddev:0.00 (0.0%) 14:24:29 INFO - PROCESS | 18175 | Values: 25575.0 14:24:29 INFO - PROCESS | 18175 | 14:24:29 INFO - PROCESS | 18175 | [#8] Splay Cycles:1 Average:600.60 Median:600.60 stddev:0.00 (0.0%) 14:24:29 INFO - PROCESS | 18175 | Values: 600.6 14:24:29 INFO - PROCESS | 18175 | 14:24:29 INFO - PROCESS | 18175 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 14:24:29 INFO - PROCESS | 18175 | Values: 4835.7 14:24:29 INFO - PROCESS | 18175 | -------- Summary: end -------- 14:24:29 INFO - PROCESS | 18175 | 14:24:30 INFO - TEST-INFO | 18175: exit 0 14:24:30 INFO - TEST-OK | v8_7 | took 40654ms 14:24:30 INFO - SUITE-END | took 1216s 14:24:30 INFO - Completed test suite (00:20:16) 14:24:30 INFO - Working with test: dromaeo_css 14:24:30 INFO - Generating results file: dromaeo_css 14:24:30 INFO - Working with test: kraken 14:24:30 INFO - Generating results file: kraken 14:24:30 INFO - javascript benchmark 14:24:30 INFO - Working with test: v8_7 14:24:30 INFO - Generating results file: v8_7 14:24:30 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:24:30 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 14:24:30 INFO - process_Request line: dromaeo_css 6823.34 graph.html#tests=[[72,64,35]] 14:24:30 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:24:30 INFO - process_Request line: kraken 1503.90 graph.html#tests=[[232,64,35]] 14:24:30 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:24:30 INFO - process_Request line: v8_7 19798.32 graph.html#tests=[[230,64,35]] 14:24:30 INFO - RETURN: dromaeo_css: 6823.34 14:24:30 INFO - RETURN: kraken: 1503.90 14:24:30 INFO - RETURN: v8_7: 19798.32 14:24:30 INFO - javascript benchmark 14:24:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3110.7666924980626, 3140.71733543981, 3174.3016536362006, 3178.3961047400994, 3211.10089175031, 5042.294078828967, 5222.399424066233, 5234.92147617786, 5240.161574148137, 5286.418493965661, 5191.558717509007, 5196.0, 5231.555317797992, 5234.528892399683, 5312.309399778023, 4774.307725379836, 4796.3045358423005, 4844.781984810692, 4904.239842824368, 4919.040787046527, 4853.927191092136, 4854.684445511049, 4931.235658472924, 4934.383202099738, 4935.5804756595735, 4748.7863046163, 4750.643701722384, 4833.130036593412, 4857.465678775332, 4865.732384718839, 4726.0, 4737.123632128068, 4744.976275118637, 4748.19280722278, 4784.330193772875, 4702.153612349775, 4736.786844592001, 4738.644601654855, 4754.453237877654, 4765.951490672047, 5032.823851165192, 5098.923516147223, 5136.126858434038, 5224.63427560071, 5256.50063243995, 5664.631798933056, 5672.461116193955, 5688.943110568925, 5693.743781529841, 5732.140178973145, 5722.456366645162, 5736.426357364272, 5738.68437235956, 5740.1102829061565, 5744.626599271034, 5170.405403378584, 5251.816186433456, 5251.842444726664, 5325.866853328659, 5343.65266257692, 5776.826695199151, 5849.2103566018895, 5858.853528661817, 5859.44335288147, 5887.4406931341455, 5611.102223644198, 5620.887582248414, 5625.409332020161, 5632.718364081779, 5684.431556844283, 5594.13290939905, 5650.519705825051, 5663.9716801415725, 5666.773329066874, 5706.115552089433, 5529.281193444907, 5641.294838145232, 5763.164341170507, 5763.538916886723, 5781.797637082682, 5616.213730077792, 5648.491635752802, 5659.066254068115, 5666.886662266732, 5669.06460434032, 4358.128374325084, 4376.803043863034, 4387.451568553931, 4396.120775844844, 4419.469663640384, 3818.6372294631965, 3855.383138697795, 3859.073822282688, 3915.6084391561185, 3969.861054863066, 5261.657992230493, 5278.5249327560705, 5279.736013199325, 5325.573954083664, 5329.387120481194, 5535.944640553543, 5648.096304591328, 5679.858003549944, 5687.317521897398, 5696.231008813757, 5197.922031169535, 5221.373435187726, 5261.631685781958, 5279.47205279469, 5338.54622357104, 4873.853784386474, 4878.829240976549, 4880.877978050577, 4884.609231261491, 4923.507649235119, 5667.40492248308, 5755.85610359736, 5758.942410575841, 5764.279465066867, 5766.88466230673, 5610.186522954067, 5616.241807356118, 5647.0, 5653.745581448927, 5716.3140423147825, 5881.852953676193, 5885.499732522612, 5891.734871930687, 5919.052951527735, 5952.702364881652, 5662.490375866192, 5667.518260947701, 5672.064109421899, 5673.489385955284, 5680.545556355399, 5573.498385145194, 5673.858153546194, 5674.092145256739, 5685.715714214355, 5752.223449834219, 5526.585506086979, 5576.581756368208, 5577.609567330248, 5586.413426590149, 5639.6334238274385, 5493.395726470165, 5500.202470641654, 5502.367227768857, 5505.614606977473, 5516.503514683698, 5289.0, 5416.431274716256, 5421.812437281933, 5460.126379779216, 5463.48096930791, 5475.698836564027, 5498.532624726943, 5550.333959924674, 5612.382637909908, 5626.2685850839125, 5467.152591348188, 5510.366307874646, 5511.779528818963, 5520.06158952971, 5526.364468086222], "unit": "score", "name": "dojo.html", "value": 5220.454081114205}, {"lowerIsBetter": false, "replicates": [532.9607265831627, 539.9163129714894, 555.3641080962299, 562.9465200805922, 585.3297973819973, 27686.16941491756, 28582.857085714542, 28598.28504287391, 28598.714012859866, 28625.85687071567, 28849.0, 29422.705772942263, 36844.0, 37355.25289494209, 37384.0, 8473.322134229262, 8601.225889669928, 8608.053114157437, 8619.0, 8620.137986201393, 5947.851303717398, 5953.58324917256, 5953.642781433128, 5958.8808223835495, 6171.907421388661, 7626.771196864103, 7812.960935195316, 10123.08892199702, 10341.948290258539, 10344.844827327595, 9980.351277166998, 10080.798384032278, 10084.64703735373, 10087.49562521871, 10099.646512372032, 7559.206283340225, 7742.419318551075, 10105.797884042278, 10235.846462303072, 10261.846072308921, 38984.41523377151, 39377.40933885994, 39491.802540987395, 39646.0, 39675.20649587021, 3059.4147944986453, 3243.4323993301314, 3439.9656003439895, 3893.4549163117185, 3933.98033009836, 26619.733802661918, 27177.1846844595, 27311.180664580093, 27625.171244862486, 27865.58201626977, 3700.8149592520267, 3730.235301763132, 3744.719146064029, 3790.8104594770425, 3810.8475660973804, 285223.5738821313, 285695.0, 285926.0, 286713.0, 286963.0, 56778.716106419204, 57564.71217643969, 57678.4232157673, 57681.42318576844, 57691.423085768605, 60111.699441503384, 60432.0, 60527.69736151379, 60673.69663151656, 60704.392956070755, 13849.723005539832, 13870.375833087535, 13892.374843132084, 13945.930270348787, 13948.651283717989, 11240.831387529193, 11303.0, 11303.208775385809, 11310.491027903765, 11316.094712422986, 18211.163416274227, 19021.524461888286, 19076.71384929227, 19178.13698383576, 19191.712124318146, 7201.17186523546, 7357.190709022003, 7417.666205020787, 7456.7390141344795, 7484.1393239777035, 929.0802105915095, 947.1286416496839, 947.4552132523827, 997.9850302245472, 1001.8046480936148, 30157.396852063273, 31183.376332473224, 31298.530522042187, 31644.525332120036, 31861.362772744415, 959.5825815770162, 969.1616751509894, 1014.5586669798661, 1064.43052966664, 1065.5205157679075, 13742.725145497034, 14458.204798736171, 14992.175430351217, 15213.919223781686, 15337.386504539916, 298779.0, 301214.0, 301551.0, 302394.0, 303096.0, 54271.72864135654, 55384.0, 55528.44471555314, 56465.0, 56667.71666141643, 1389.6317475868902, 1392.324722509582, 1394.0381137015427, 1394.8395934467667, 1395.846456889721, 27897.860510698127, 28058.57912131279, 29098.41803163967, 29985.250368740955, 31648.0, 47773.76113119412, 48783.268250975554, 48865.0, 48981.0, 49002.75498622484, 229194.0, 233856.0, 234359.0, 234518.0, 234624.0, 42372.0, 42743.0, 42932.35601465918, 43237.35143972906, 43681.34477982769, 45419.772901135286, 45713.31430028486, 45782.0, 46423.53576464192, 46734.53265467302, 36866.44700329444, 38647.2270554593, 38813.805930970164, 39029.6097039026, 39645.0, 34237.315253695284, 35951.0, 36944.07639809026, 37424.0, 39092.0, 33350.666493335724, 33833.66166338305, 34246.657533424346, 34295.31409371849, 34352.141196470286, 28725.56911646285, 30847.537286941162, 31440.0, 31451.213719657193, 31498.52752208673, 24043.158489452784, 24081.75918240795, 24430.755692442846, 25275.368115797253, 25408.0], "unit": "score", "name": "ext.html", "value": 18095.046480799585}, {"lowerIsBetter": false, "replicates": [350.9017475106969, 356.04934824019864, 357.58162949349264, 358.79010778694465, 359.2778515184479, 14172.433102675906, 14456.494022709207, 15795.526134215977, 15824.0, 16475.835241647565, 15085.472008479677, 15101.244937753123, 15469.149196794171, 15480.380784768597, 15486.457973970913, 5218.165093585008, 5259.342582177237, 5368.141097424413, 5369.087255166612, 5374.677519348832, 3738.084169378506, 3832.5400951885813, 5272.841814745545, 5278.498542638463, 5376.8118115865955, 5294.020606187848, 5336.893262134755, 5349.331333583302, 5355.0, 5363.758630861601, 5297.023785808185, 5972.134040564116, 6035.396460353973, 6039.516838652898, 6045.576809623328, 5341.626086173969, 5373.811916582901, 5376.516113549799, 5378.0, 5380.166074258496, 13114.47542098315, 13135.211887286794, 13135.671608209776, 13828.308584570832, 15808.446704365291, 2067.8759274443582, 2079.189116244666, 2122.310249169026, 2187.5187458759206, 2194.846360754732, 9670.129688328014, 9760.072793084646, 9772.95113524435, 12072.637820865388, 12305.75388492234, 1847.9260829566801, 1850.8334249917436, 1853.8887666740038, 1862.9161687724086, 1893.422506135628, 55822.72088639571, 56896.715516422155, 58677.0, 59266.0, 60487.395126048614, 10276.177905767521, 10311.74220644475, 10319.587216511405, 10325.690229293134, 10385.84421233682, 13524.256165910772, 13539.66150846217, 13543.45826166962, 13558.86441135576, 13562.389692463863, 6888.311168883071, 6912.101426814482, 6931.618760968196, 6977.89533157003, 6983.336583024605, 6263.71813268404, 6306.3378345274, 6321.778737744249, 6398.520110991694, 6502.44729198014, 4413.426254586883, 4434.224010798098, 4457.8439754608435, 4482.417285752831, 4531.342955271467, 1735.3752649046585, 1779.0926627419851, 1784.4111443223705, 1791.3551121596215, 1839.705647096458, 451.58003057156503, 451.61612629265517, 895.0512456795688, 921.8386782313203, 1002.7142264454595, 9247.26021918245, 10230.795384092426, 10358.792824143475, 10537.57849686004, 10624.0, 464.8930745928388, 869.599984007351, 892.312919052339, 910.5401772105045, 956.2875657635107, 8535.97568291809, 9192.724218273463, 9209.76975575616, 9245.214156796614, 9296.209822165056, 295682.5215873907, 589288.0, 593279.0, 594915.0, 603220.0, 70743.0, 72162.0, 73355.0, 74704.0, 76034.61982690051, 1091.5961094395125, 1094.0645747885603, 1095.0801326885296, 1103.2497901426946, 1104.0560320925654, 13907.652308692364, 14227.07524010936, 14665.63335916568, 15051.623709407353, 15277.77083343773, 20438.182472700926, 27688.30779230455, 31984.84007579947, 32825.778328767636, 33254.0, 40407.0, 41270.38094428526, 41331.380029300184, 42310.78844605757, 42330.36504452374, 9490.0, 9653.9034609653, 9718.173955213602, 9955.452450115314, 10008.349457285252, 17529.474115776546, 17717.114144292475, 17852.91073544624, 17938.461846144637, 18027.639447211244, 14491.0, 14519.34662940149, 14642.853571464575, 14893.776593351326, 15069.321880515623, 14318.85681143217, 14535.127892326494, 14637.0, 14839.0, 14939.701205976036, 11570.363630000431, 12666.683332916751, 14094.295285235903, 14233.572992810232, 14627.268636567916, 9244.445333280024, 9297.395669281475, 9327.207187389147, 9424.905750942402, 9557.808843823224, 13472.461101555828, 13484.595462136152, 13694.726105478034, 13812.0, 14172.362243699265], "unit": "score", "name": "jquery.html", "value": 8373.63596216745}, {"lowerIsBetter": false, "replicates": [1275.502554003938, 1477.630592351912, 1485.3167542930248, 1646.6871294454054, 1780.4925596205085, 6602.306757790435, 7256.8911466328045, 7360.411167106632, 7377.299156580117, 7380.077490313711, 7169.82075448114, 7282.708691652328, 7338.669759860806, 7357.705691772336, 7358.779236622897, 1965.555316842127, 1999.8100180482904, 2007.3576455534235, 2210.933671989843, 2249.0, 2216.0803266644325, 2251.5609456156058, 2260.2089268755885, 2262.3326118794994, 2262.9660555091687, 2155.385715071205, 2181.792729690677, 2228.810551103158, 2232.3303009097285, 2233.02863254484, 2196.2532738868863, 2233.3411643565105, 2241.0363543676212, 2260.547890421914, 2261.705978222829, 2210.6573481110295, 2216.346177877514, 2243.8317126215597, 2244.382794731462, 2250.3361508355074, 7443.367313778335, 7526.209747976438, 7530.548167109936, 7532.435067369969, 7538.396928245727, 4478.932816007762, 4528.071745292207, 4542.568455996675, 4546.772661366918, 4547.226971414867, 2930.8241505509523, 2953.616029916119, 2972.65814431341, 2974.107767669712, 3089.891853785129, 1033.8707661542308, 1037.2376303416982, 1038.1850247555633, 1064.8935106489366, 1078.051314842941, 10283.948580257125, 10310.278280520366, 10311.742206444824, 10335.0, 10343.534540945675, 4104.979475102606, 4158.293090174678, 4188.937165942513, 4203.327467605169, 4206.453161089039, 8842.955785221162, 8849.380543361904, 8849.955750221336, 8851.424657397249, 8861.955690221508, 4476.37330773692, 4517.299818528133, 4518.344839998247, 4519.276915693474, 4524.615407690318, 4044.3326851069833, 4071.328230841937, 4075.3275709507598, 4094.7133700641266, 4101.774402407897, 3313.4698448248164, 3335.6831101045364, 3504.369213541587, 3534.6818786309354, 3597.982010089933, 1142.6743378137357, 1143.1597775634903, 1144.6508814811395, 1152.8040233160382, 1156.6876943225282, 1003.0922015575916, 1004.1966426858484, 1073.8335557988523, 1146.6388087752332, 1345.3945724424048, 6798.388145066968, 6838.281980391987, 6890.44876409886, 6893.827654308582, 6911.447084233249, 1091.47063674118, 1097.4238524774398, 1113.8663360396804, 1114.1031469666996, 1119.160629527854, 5191.506806853343, 5265.104932161542, 5266.8156614519075, 5275.050490911673, 5276.498732620472, 8791.648334066565, 8869.822603547893, 8990.640374384951, 9033.96109447422, 9100.954495227481, 8863.157999989991, 8899.288056955427, 8931.73204803857, 8985.505797181218, 8994.370394072483, 6906.102206713095, 7007.789766307019, 7105.32499412555, 7147.89278160828, 7184.820379490555, 6917.37743603058, 6921.757738479129, 6927.44580433554, 6931.168259808654, 6941.236463989058, 7683.807904802425, 7979.281864632211, 8080.2727754502375, 8083.19168083187, 8095.23095305945, 7940.880886786818, 7951.324137448381, 7953.085395179397, 8055.436119471581, 8076.71731489395, 6606.405423511907, 6615.503837212132, 6683.164604424447, 6685.832854178684, 6786.524943253925, 6487.967560162358, 6594.967025164843, 7014.719411223494, 7078.1506219254015, 7156.463265255231, 6662.267150613526, 6745.12313399255, 6776.220734615582, 6837.3162683731225, 6905.482088843457, 6564.704588293634, 6611.768588099586, 6670.299618539983, 6675.699593518206, 6693.598384096969, 6675.532712710064, 6711.261761206166, 6711.530192886451, 6716.059751634677, 6719.496037797087, 6040.546958978006, 6282.654454005074, 6326.177596912372, 6329.050642403677, 6332.30344662096, 6312.43188113072, 6335.588186767845, 6356.713947872265, 6367.61794292344, 6371.713272902638], "unit": "score", "name": "mootools.html", "value": 4321.244137812947}, {"lowerIsBetter": false, "replicates": [335.9596848378195, 337.421322432029, 339.07094560903124, 344.69150110650986, 347.90084825824636, 5861.0915308127205, 5881.588288819784, 5883.029300165473, 5895.322037965624, 5917.053271476565, 5618.803341883025, 5655.604107712462, 5744.33940096889, 5816.447437493442, 5839.036558967765, 4503.842365517207, 4516.616087632538, 4521.253993091136, 4528.003839155389, 4541.636669066484, 4360.847370342039, 4531.43357080365, 4537.9773101134615, 4538.228501154812, 4547.613452856511, 4367.71609845359, 4421.204183247014, 4544.386507821435, 4559.931601025987, 4565.1098035883015, 4515.367848501212, 4521.706089104197, 4523.6607254455885, 4538.727676339414, 4548.135854187693, 4023.97988010061, 4025.295573274665, 4028.536718277377, 4029.0, 4034.8587799427173, 5526.336839579236, 5620.91568626471, 5634.6337488063145, 5635.21107045014, 5683.886322273532, 5298.125809241471, 5308.203769434577, 5310.283111779938, 5311.468853114697, 5311.548518375943, 6224.62652240867, 6228.065790131472, 6233.0, 6235.906461403082, 6237.34507876671, 4458.9554104459185, 4459.241928872099, 4460.442444694413, 4462.263726485126, 4464.441944756905, 6335.208098987627, 6509.576877502947, 6512.967435162841, 6518.28298887122, 6520.11978382917, 4560.429946256718, 4572.3827283317, 4577.084583083397, 4577.29051996941, 4578.88552786183, 4624.630029597692, 4624.722516648944, 4631.560001799824, 4634.83778067766, 4636.79134438951, 5251.448597897166, 5280.075986702312, 5284.4187139414635, 5289.550388217045, 5299.046171689133, 6096.420840020191, 6249.6562689052535, 6252.343503932022, 6267.9373206268265, 6275.811725648238, 1614.2251719174863, 1639.4098124675345, 1641.8029836419705, 1643.786307779981, 1643.9424620138238, 1092.093562343253, 1094.0, 1102.8897110288906, 1106.8893110688866, 1148.8276758486295, 5893.6463812171405, 5895.35151133375, 5907.409259074144, 5912.852178695567, 5914.615549989323, 6420.711068001858, 6428.100065990765, 6428.903566446507, 6433.806985790434, 6436.742530298736, 5775.33583637887, 5839.649621022752, 5906.0, 5984.611000284967, 5991.7902873399225, 3471.8437670304897, 3486.773359731609, 3492.1444246159854, 3496.440569508917, 3500.3524347995703, 6625.668716564152, 6660.533762636569, 6677.699503522354, 6680.632565208863, 6680.799576012728, 6476.6114033158165, 6675.399214070757, 6683.7660681875905, 6692.83267918306, 6698.799036028927, 6688.030235615905, 6697.564658297195, 6698.196216453959, 6699.564528305645, 6699.79900602973, 6439.7424103035355, 6479.254885688206, 6494.415502604788, 6496.675166241764, 6501.902471463027, 6318.557700961072, 6391.9041214380895, 6400.935990640221, 6424.646644434414, 6430.260520040255, 6662.933370666231, 6675.332466753286, 6678.532502724763, 6681.699323530355, 6685.76599819004, 4469.709468884512, 4500.7524586146765, 4505.7296562206375, 4514.774261286988, 4518.028623845889, 6295.842603934938, 6498.317676643885, 6521.934780652133, 6526.412622863965, 6538.738450461929, 6350.015747559136, 6367.204099487564, 6369.0, 6373.171487706569, 6374.904376434264, 6330.588511746721, 6332.145160403286, 6336.809895703136, 6345.555811093179, 6352.0789485525265, 6080.69596520181, 6219.0, 6228.439440450381, 6230.43926046658, 6234.064890266496, 6357.554971151975, 6367.745290188526, 6372.044193371032, 6375.075614036032, 6386.648734319657, 6218.0, 6274.498040156868, 6278.46633036197, 6278.843028924313, 6282.528810339151], "unit": "score", "name": "prototype.html", "value": 4758.355629103467}, {"lowerIsBetter": false, "replicates": [738.0331765387343, 759.108048043549, 813.1258896686064, 839.1566475691928, 844.4806444036917, 13510.932445337772, 13773.51792687256, 13833.654158646039, 13856.722865542682, 13870.861291387084, 12862.356882155878, 12874.742505149892, 12887.355632218398, 12906.096573239876, 12914.74170516589, 675.5912672832939, 794.9046114466272, 804.7424824056304, 804.8752443371287, 806.2582424169777, 681.0363335879724, 794.0, 822.6051495282268, 825.471698113208, 825.694493037577, 857.2713193785295, 857.9656813727444, 864.5115509736978, 865.074370423647, 866.0689758509595, 699.1016543741268, 712.3304094151481, 860.2129051917487, 860.9969385665692, 861.452977359375, 620.7765204526366, 631.8894193516117, 633.9112524246609, 634.4004915354991, 634.5336177909234, 13287.269200193985, 13357.666058348523, 13452.596422107352, 13466.596002119952, 13469.797953030713, 11048.337099774039, 11191.384473853936, 11325.490352934137, 11336.376499292535, 12752.426140823685, 10187.643432479828, 10239.12967397772, 10562.419066951315, 10969.83545246822, 10987.670369888836, 3653.2328211075705, 3720.1257704439436, 3747.2505498900327, 3757.981210093932, 3821.159344944108, 48106.518934810556, 48764.0, 48767.512324876654, 49287.50712492865, 49310.50689493095, 9987.950060249652, 10047.296689231684, 10245.077942985166, 10310.32982856127, 10481.423521706227, 17811.198496067707, 17819.554511137325, 17838.286468541373, 17850.19674114668, 17938.103094845468, 7130.750423735144, 7244.710211591478, 7355.0, 7357.5217610855125, 7399.704011839466, 4305.935410968838, 4333.263345231318, 4390.209762242827, 4444.644428445781, 4451.154280686659, 3117.314190878003, 3124.8594263093805, 3131.0919833248104, 3136.2316232523176, 3141.8429078545983, 555.5777609017176, 561.264743186427, 566.1309889319956, 573.3692937768421, 573.6672729816696, 487.89754151628557, 507.56603104345993, 519.158962480776, 534.9277847490539, 598.4793229890023, 7919.168487308865, 8078.8788168177525, 8109.229623185788, 8192.795180120425, 8360.56226293475, 534.8475684429919, 623.3486007122568, 638.3297537585516, 660.6729668813967, 666.73997141115, 3775.8867233982473, 3959.9437981898, 4019.457373254632, 4074.0629655179473, 4333.761643109596, 56753.43246567564, 56914.43085569174, 57040.71479642658, 60079.0, 60372.0, 50255.0, 51484.74257628688, 51580.74209628928, 51697.48302516927, 51831.22253166205, 48261.27608085952, 48686.5131348689, 48757.75621121943, 49127.75436122796, 50400.49599504031, 8311.418200725891, 8314.16858314188, 8415.200555947175, 8455.8731619027, 8788.780280493038, 35871.46192807058, 36241.27517449584, 36391.818040909624, 37347.626523735504, 37354.44806707046, 42957.14085718331, 43040.354394683476, 45551.31673024841, 47936.28095578499, 48401.5159848397, 10062.855372685475, 10315.896841031494, 10352.482375881327, 10548.972044379307, 10860.239783215098, 11350.205485615928, 11723.941380293043, 11872.821907671565, 11934.641960741192, 11941.223820451643, 10623.89376106229, 10801.945990269998, 11055.889441105808, 11126.109911207246, 11275.267107637977, 10620.415877126523, 11076.556937722724, 11175.944120279346, 11316.717082072684, 11483.48324325424, 10243.129334006395, 10248.487575621339, 10713.196510261918, 10730.517126729159, 10782.73043173927, 8982.416142950688, 8994.235489983163, 9215.631374744935, 9345.345825792128, 9362.0, 8702.825943480968, 8706.521141337287, 8765.254953328784, 9149.908500914906, 9342.486163261086], "unit": "score", "name": "yui.html", "value": 6204.323274594771}], "name": "dromaeo_css", "value": 6823.337462172184}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 110.0, 105.0, 111.0, 111.0, 111.0, 99.0, 110.0, 110.0, 100.0], "unit": "score", "name": "ai-astar", "value": 107.7}, {"lowerIsBetter": true, "replicates": [151.0, 124.0, 145.0, 167.0, 126.0, 149.0, 152.0, 123.0, 175.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 143.8}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 160.0, 161.0, 162.0, 162.0, 161.0, 163.0, 163.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.5}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 83.0, 95.0, 71.0, 72.0, 72.0, 96.0, 91.0, 71.0], "unit": "score", "name": "audio-fft", "value": 79.5}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 143.0, 95.0, 95.0, 96.0, 138.0, 96.0, 96.0, 141.0], "unit": "score", "name": "audio-oscillator", "value": 109.2}, {"lowerIsBetter": true, "replicates": [109.0, 108.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 108.9}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 145.0, 145.0, 146.0, 145.0, 145.0, 146.0, 145.0, 144.0], "unit": "score", "name": "imaging-darkroom", "value": 145.2}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 96.0, 97.0, 95.0, 96.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [57.0, 58.0, 61.0, 58.0, 61.0, 58.0, 60.0, 66.0, 56.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 59.1}, {"lowerIsBetter": true, "replicates": [67.0, 69.0, 68.0, 69.0, 69.0, 69.0, 69.0, 69.0, 68.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.6}, {"lowerIsBetter": true, "replicates": [87.0, 89.0, 88.0, 93.0, 88.0, 87.0, 89.0, 87.0, 88.0, 88.0], "unit": "score", "name": "stanford-crypto-aes", "value": 88.4}, {"lowerIsBetter": true, "replicates": [116.0, 135.0, 118.0, 119.0, 134.0, 123.0, 124.0, 114.0, 116.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.9}, {"lowerIsBetter": true, "replicates": [140.0, 143.0, 150.0, 151.0, 167.0, 140.0, 154.0, 140.0, 149.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.2}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 66.0, 67.0, 67.0, 68.0, 67.0, 66.0, 67.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.1}], "name": "kraken", "value": 1503.9}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.54879487611663], "unit": "score", "name": "Richards", "value": 209.44676600000008}, {"lowerIsBetter": false, "replicates": [191.79133103183736], "unit": "score", "name": "DeltaBlue", "value": 344.73925199999996}, {"lowerIsBetter": false, "replicates": [280.42624789680315], "unit": "score", "name": "Encrypt", "value": 949.2014460000001}, {"lowerIsBetter": false, "replicates": [5256.544502617801], "unit": "score", "name": "Decrypt", "value": 50.6380189243028}, {"lowerIsBetter": false, "replicates": [1962.7450980392157], "unit": "score", "name": "RayTrace", "value": 377.0173726273725}, {"lowerIsBetter": false, "replicates": [811.0300081103001], "unit": "score", "name": "Earley", "value": 821.7488789999996}, {"lowerIsBetter": false, "replicates": [11928.57142857143], "unit": "score", "name": "Boyer", "value": 55.871149700598814}, {"lowerIsBetter": false, "replicates": [25575.0], "unit": "score", "name": "RegExp", "value": 35.620136852394914}, {"lowerIsBetter": false, "replicates": [600.6006006006006], "unit": "score", "name": "Splay", "value": 135.68251500000005}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 19798.316071284513}]} 14:24:30 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "19798.32"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1503.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6823.34"}}} 14:24:30 INFO - Return code: 0 14:24:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 14:24:30 INFO - # TBPL SUCCESS # 14:24:30 INFO - Running post-action listener: _resource_record_post_action 14:24:30 INFO - Running post-run listener: _resource_record_post_run 14:24:31 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 9400320; Write bytes: 553336832; Read time: 2424; Write time: 783512 14:24:31 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 4096; Write bytes: 235458560; Read time: 224; Write time: 503168 14:24:31 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 7659520; Write bytes: 317878272; Read time: 2128; Write time: 280344 14:24:31 INFO - Running post-run listener: _upload_blobber_files 14:24:31 INFO - Blob upload gear active. 14:24:31 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 14:24:31 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 14:24:31 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'] 14:24:31 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 14:24:32 INFO - (blobuploader) - INFO - Open directory for files ... 14:24:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:24:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:24:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:24:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:24:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:24:32 INFO - (blobuploader) - INFO - Done attempting. 14:24:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 14:24:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:24:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:24:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:24:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:24:33 INFO - (blobuploader) - INFO - Done attempting. 14:24:33 INFO - (blobuploader) - INFO - Iteration through files over. 14:24:33 INFO - Return code: 0 14:24:33 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 14:24:33 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 14:24:33 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/835fcbff25b9bd4b54d048187a2b102b5a4eef70a63adb24e155695eb35562e430f183a5d473191728e9d207d6ad234ade0b6c19c1b23acdcfc773484d4b13fd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/acc53b94362dc2f292d58087862850fa92f83bedba93bb933e0c488d95e16841277b54cde367b046719b6e4861d31ac679e8671e3c6cf2b262cc9a6e2f958db0"} 14:24:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 14:24:33 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 14:24:33 INFO - Contents: 14:24:33 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/835fcbff25b9bd4b54d048187a2b102b5a4eef70a63adb24e155695eb35562e430f183a5d473191728e9d207d6ad234ade0b6c19c1b23acdcfc773484d4b13fd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/acc53b94362dc2f292d58087862850fa92f83bedba93bb933e0c488d95e16841277b54cde367b046719b6e4861d31ac679e8671e3c6cf2b262cc9a6e2f958db0"} 14:24:33 INFO - Copying logs to upload dir... 14:24:33 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1278.608479 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2015-12-31 14:24:33.711014) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-31 14:24:33.714792) ========= 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=76a4ffbc7ba64825c1a171dc000001de-1451598936.245095-1445681370 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/835fcbff25b9bd4b54d048187a2b102b5a4eef70a63adb24e155695eb35562e430f183a5d473191728e9d207d6ad234ade0b6c19c1b23acdcfc773484d4b13fd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/acc53b94362dc2f292d58087862850fa92f83bedba93bb933e0c488d95e16841277b54cde367b046719b6e4861d31ac679e8671e3c6cf2b262cc9a6e2f958db0"} build_url:https://queue.taskcluster.net/v1/task/QTRcrkpjQO2wNtnonOtWjw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011265 build_url: 'https://queue.taskcluster.net/v1/task/QTRcrkpjQO2wNtnonOtWjw/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/835fcbff25b9bd4b54d048187a2b102b5a4eef70a63adb24e155695eb35562e430f183a5d473191728e9d207d6ad234ade0b6c19c1b23acdcfc773484d4b13fd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/acc53b94362dc2f292d58087862850fa92f83bedba93bb933e0c488d95e16841277b54cde367b046719b6e4861d31ac679e8671e3c6cf2b262cc9a6e2f958db0"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-31 14:24:33.738691) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 14:24:33.738968) ========= 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=76a4ffbc7ba64825c1a171dc000001de-1451598936.245095-1445681370 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004440 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 14:24:33.824326) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-31 14:24:33.824644) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-31 14:24:33.824938) ========= ========= Total master_lag: 0.19 =========