builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-044 starttime: 1453252514.41 results: success (0) buildid: 20160119143009 builduid: cae9caf2646b46c29bde4ac7768cac5f revision: 48e077b052981e34081e4b8158678fee4f52e88c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-19 17:15:14.407581) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-19 17:15:14.407983) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-19 17:15:14.408280) ========= 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=574dc5aafe09851ec43d388c000001b6-1453251771.124468-664606412 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006421 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.07 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-19 17:15:14.479978) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-19 17:15:14.480311) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-19 17:15:14.585143) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 17:15:14.586467) ========= 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=574dc5aafe09851ec43d388c000001b6-1453251771.124468-664606412 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.025093 ========= master_lag: 0.10 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 17:15:14.706562) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-19 17:15:14.706891) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-19 17:15:14.707260) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 17:15:14.707553) ========= 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=574dc5aafe09851ec43d388c000001b6-1453251771.124468-664606412 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-19 17:15:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 35.1M=0s 2016-01-19 17:15:14 (35.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.098491 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 17:15:14.840145) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 17:15:14.840531) ========= 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=574dc5aafe09851ec43d388c000001b6-1453251771.124468-664606412 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.070376 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 17:15:14.924775) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 17:15:14.925129) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 48e077b052981e34081e4b8158678fee4f52e88c --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 48e077b052981e34081e4b8158678fee4f52e88c --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=574dc5aafe09851ec43d388c000001b6-1453251771.124468-664606412 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-19 17:15:15,002 truncating revision to first 12 chars 2016-01-19 17:15:15,002 Setting DEBUG logging. 2016-01-19 17:15:15,002 attempt 1/10 2016-01-19 17:15:15,002 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/48e077b05298?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-19 17:15:15,308 unpacking tar archive at: fx-team-48e077b05298/testing/mozharness/ program finished with exit code 0 elapsedTime=0.617771 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 17:15:15.558894) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-19 17:15:15.559208) ========= echo '%(revision)s' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', '%(revision)s'] 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=574dc5aafe09851ec43d388c000001b6-1453251771.124468-664606412 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False %(revision)s program finished with exit code 0 elapsedTime=0.003484 script_repo_revision: '%(revision)s' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-19 17:15:15.609459) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-19 17:15:15.609828) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-19 17:15:15.626073) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-19 17:15:15.626447) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/%(revision)s ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-19 17:15:15.626875) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-01-19 17:15:15.627155) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=574dc5aafe09851ec43d388c000001b6-1453251771.124468-664606412 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:15:15 INFO - MultiFileLogger online at 20160119 17:15:15 in /builds/slave/test-pgo 17:15:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 17:15:15 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 17:15:15 INFO - {'append_to_log': False, 17:15:15 INFO - 'base_work_dir': '/builds/slave/test-pgo', 17:15:15 INFO - 'blob_upload_branch': 'Fx-Team', 17:15:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 17:15:15 INFO - 'branch': 'Fx-Team', 17:15:15 INFO - 'buildbot_json_path': 'buildprops.json', 17:15:15 INFO - 'config_files': ('talos/linux_config.py',), 17:15:15 INFO - 'default_actions': ('clobber', 17:15:15 INFO - 'read-buildbot-config', 17:15:15 INFO - 'download-and-extract', 17:15:15 INFO - 'populate-webroot', 17:15:15 INFO - 'create-virtualenv', 17:15:15 INFO - 'install', 17:15:15 INFO - 'run-tests'), 17:15:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:15:15 INFO - 'download_minidump_stackwalk': True, 17:15:15 INFO - 'download_symbols': 'ondemand', 17:15:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:15:15 INFO - 'tooltool.py': '/tools/tooltool.py', 17:15:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:15:15 INFO - '/tools/misc-python/virtualenv.py')}, 17:15:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:15:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:15:15 INFO - 'installer_path': 'installer.exe', 17:15:15 INFO - 'log_level': 'info', 17:15:15 INFO - 'log_name': 'talos', 17:15:15 INFO - 'log_to_console': True, 17:15:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:15:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:15:15 INFO - 'opt_config_files': (), 17:15:15 INFO - 'pip_index': False, 17:15:15 INFO - 'sps_profile': False, 17:15:15 INFO - 'sps_profile_interval': 0, 17:15:15 INFO - 'suite': 'dromaeojs-e10s', 17:15:15 INFO - 'system_bits': '32', 17:15:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:15:15 INFO - 'title': 'talos-linux64-ix-044', 17:15:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:15:15 INFO - 'use_talos_json': True, 17:15:15 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 17:15:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:15:15 INFO - 'work_dir': 'build'} 17:15:15 INFO - ##### 17:15:15 INFO - ##### Running clobber step. 17:15:15 INFO - ##### 17:15:15 INFO - Running pre-action listener: _resource_record_pre_action 17:15:15 INFO - Running main action method: clobber 17:15:15 INFO - rmtree: /builds/slave/test-pgo/build 17:15:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 17:15:16 INFO - Running post-action listener: _resource_record_post_action 17:15:16 INFO - ##### 17:15:16 INFO - ##### Running read-buildbot-config step. 17:15:16 INFO - ##### 17:15:16 INFO - Running pre-action listener: _resource_record_pre_action 17:15:16 INFO - Running main action method: read_buildbot_config 17:15:16 INFO - Using buildbot properties: 17:15:16 INFO - { 17:15:16 INFO - "project": "", 17:15:16 INFO - "product": "firefox", 17:15:16 INFO - "script_repo_revision": "production", 17:15:16 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 17:15:16 INFO - "repository": "", 17:15:16 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 17:15:16 INFO - "buildid": "20160119143009", 17:15:16 INFO - "pgo_build": "True", 17:15:16 INFO - "basedir": "/builds/slave/test-pgo", 17:15:16 INFO - "buildnumber": 222, 17:15:16 INFO - "slavename": "talos-linux64-ix-044", 17:15:16 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:15:16 INFO - "platform": "ubuntu64_hw", 17:15:16 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 17:15:16 INFO - "branch": "fx-team", 17:15:16 INFO - "repo_path": "integration/fx-team", 17:15:16 INFO - "revision": "48e077b052981e34081e4b8158678fee4f52e88c", 17:15:16 INFO - "stage_platform": "linux64-pgo", 17:15:16 INFO - "builduid": "cae9caf2646b46c29bde4ac7768cac5f", 17:15:16 INFO - "slavebuilddir": "test" 17:15:16 INFO - } 17:15:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/FD2urM-AT6an-vdyRR3ocQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 17:15:16 INFO - Running post-action listener: _resource_record_post_action 17:15:16 INFO - ##### 17:15:16 INFO - ##### Running download-and-extract step. 17:15:16 INFO - ##### 17:15:16 INFO - Running pre-action listener: _resource_record_pre_action 17:15:16 INFO - Running main action method: download_and_extract 17:15:16 INFO - mkdir: /builds/slave/test-pgo/build/tests 17:15:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:15:16 INFO - https://queue.taskcluster.net/v1/task/FD2urM-AT6an-vdyRR3ocQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 17:15:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FD2urM-AT6an-vdyRR3ocQ/artifacts/public/build/test_packages.json 17:15:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FD2urM-AT6an-vdyRR3ocQ/artifacts/public/build/test_packages.json 17:15:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FD2urM-AT6an-vdyRR3ocQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 17:15:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FD2urM-AT6an-vdyRR3ocQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 17:15:18 INFO - Downloaded 1448 bytes. 17:15:18 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 17:15:18 INFO - Using the following test package requirements: 17:15:18 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 17:15:18 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:15:18 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:15:18 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:15:18 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:15:18 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:15:18 INFO - u'jsshell-linux-x86_64.zip'], 17:15:18 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:15:18 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:15:18 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 17:15:18 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:15:18 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:15:18 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:15:18 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:15:18 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:15:18 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:15:18 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 17:15:18 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:15:18 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:15:18 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:15:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:15:18 INFO - https://queue.taskcluster.net/v1/task/FD2urM-AT6an-vdyRR3ocQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:15:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FD2urM-AT6an-vdyRR3ocQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:15:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FD2urM-AT6an-vdyRR3ocQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:15:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FD2urM-AT6an-vdyRR3ocQ/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 17:15:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FD2urM-AT6an-vdyRR3ocQ/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 17:15:19 INFO - Downloaded 22485690 bytes. 17:15:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 17:15:19 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 17:15:20 INFO - Return code: 0 17:15:20 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 17:15:20 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')]} 17:15:20 INFO - https://queue.taskcluster.net/v1/task/FD2urM-AT6an-vdyRR3ocQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:15:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FD2urM-AT6an-vdyRR3ocQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:15:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FD2urM-AT6an-vdyRR3ocQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:15:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FD2urM-AT6an-vdyRR3ocQ/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 17:15:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FD2urM-AT6an-vdyRR3ocQ/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 17:15:22 INFO - Downloaded 22485690 bytes. 17:15:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 17:15:22 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 17:15:23 INFO - Return code: 0 17:15: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')]} 17:15:23 INFO - https://queue.taskcluster.net/v1/task/FD2urM-AT6an-vdyRR3ocQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:15:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FD2urM-AT6an-vdyRR3ocQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 17:15:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FD2urM-AT6an-vdyRR3ocQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 17:15:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FD2urM-AT6an-vdyRR3ocQ/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 17:15:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FD2urM-AT6an-vdyRR3ocQ/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 17:15:25 INFO - Downloaded 11132144 bytes. 17:15:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 17:15:25 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 17:15:25 INFO - Return code: 0 17:15:25 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')]} 17:15:25 INFO - https://queue.taskcluster.net/v1/task/FD2urM-AT6an-vdyRR3ocQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:15:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FD2urM-AT6an-vdyRR3ocQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:15:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FD2urM-AT6an-vdyRR3ocQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:15:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FD2urM-AT6an-vdyRR3ocQ/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 17:15:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FD2urM-AT6an-vdyRR3ocQ/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 17:15:28 INFO - Downloaded 55965789 bytes. 17:15:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FD2urM-AT6an-vdyRR3ocQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:15:28 INFO - mkdir: /builds/slave/test-pgo/properties 17:15:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 17:15:28 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 17:15:28 INFO - Contents: 17:15:28 INFO - build_url:https://queue.taskcluster.net/v1/task/FD2urM-AT6an-vdyRR3ocQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:15:28 INFO - Running post-action listener: _resource_record_post_action 17:15:28 INFO - Running post-action listener: set_extra_try_arguments 17:15:28 INFO - ##### 17:15:28 INFO - ##### Running populate-webroot step. 17:15:28 INFO - ##### 17:15:28 INFO - Running pre-action listener: _resource_record_pre_action 17:15:28 INFO - Running main action method: populate_webroot 17:15:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:15:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:15:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:15:28 INFO - '--tppagecycles', 17:15:28 INFO - '7'], 17:15:28 INFO - 'tests': ['tsvgm']}}, 17:15:28 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:15:28 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:15:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:15:28 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:15:28 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:15:28 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:15:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:15:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:15:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:15:28 INFO - 'talos_options': ['--e10s'], 17:15:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:15:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:15:28 INFO - 'tests': ['damp', 'tps']}, 17:15:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:15:28 INFO - 'talos_options': ['--e10s'], 17:15:28 INFO - 'tests': ['damp', 'tps']}, 17:15:28 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:15:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:15:28 INFO - 'other': {'tests': ['a11yr', 17:15:28 INFO - 'ts_paint', 17:15:28 INFO - 'tpaint', 17:15:28 INFO - 'sessionrestore', 17:15:28 INFO - 'sessionrestore_no_auto_restore']}, 17:15:28 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:15:28 INFO - 'tests': ['a11yr', 17:15:28 INFO - 'ts_paint', 17:15:28 INFO - 'tpaint', 17:15:28 INFO - 'sessionrestore', 17:15:28 INFO - 'sessionrestore_no_auto_restore']}, 17:15:28 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:15:28 INFO - 'tests': ['a11yr', 17:15:28 INFO - 'ts_paint', 17:15:28 INFO - 'tpaint', 17:15:28 INFO - 'sessionrestore', 17:15:28 INFO - 'sessionrestore_no_auto_restore']}, 17:15:28 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:15:28 INFO - 'tests': ['a11yr', 17:15:28 INFO - 'ts_paint', 17:15:28 INFO - 'tpaint', 17:15:28 INFO - 'sessionrestore', 17:15:28 INFO - 'sessionrestore_no_auto_restore']}, 17:15:28 INFO - 'other_l64': {'tests': ['a11yr', 17:15:28 INFO - 'ts_paint', 17:15:28 INFO - 'tpaint', 17:15:28 INFO - 'sessionrestore', 17:15:28 INFO - 'sessionrestore_no_auto_restore']}, 17:15:28 INFO - 'other_nol64': {'tests': ['a11yr', 17:15:28 INFO - 'ts_paint', 17:15:28 INFO - 'tpaint', 17:15:28 INFO - 'sessionrestore', 17:15:28 INFO - 'sessionrestore_no_auto_restore']}, 17:15:28 INFO - 'svgr': {'tests': ['tsvgx', 17:15:28 INFO - 'tsvgr_opacity', 17:15:28 INFO - 'tart', 17:15:28 INFO - 'tscrollx', 17:15:28 INFO - 'cart']}, 17:15:28 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:15:28 INFO - 'tests': ['tsvgx', 17:15:28 INFO - 'tsvgr_opacity', 17:15:28 INFO - 'tart', 17:15:28 INFO - 'tscrollx', 17:15:28 INFO - 'cart']}, 17:15:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:15:28 INFO - 'tests': ['tp5o']}, 17:15:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:15:28 INFO - 'talos_options': ['--e10s'], 17:15:28 INFO - 'tests': ['tp5o']}, 17:15:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:15:28 INFO - 'talos_options': ['--xperf_path', 17:15:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:15:28 INFO - 'tests': ['tp5n']}, 17:15:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:15:28 INFO - 'talos_options': ['--e10s', 17:15:28 INFO - '--xperf_path', 17:15:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:15:28 INFO - 'tests': ['tp5n']}}, 17:15:28 INFO - 'talos.zip': {'path': '', 17:15:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:15:28 INFO - Running post-action listener: _resource_record_post_action 17:15:28 INFO - ##### 17:15:28 INFO - ##### Running create-virtualenv step. 17:15:28 INFO - ##### 17:15:28 INFO - Running pre-action listener: _resource_record_pre_action 17:15:28 INFO - Running main action method: create_virtualenv 17:15:28 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 17:15:28 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 17:15:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 17:15:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:15:28 INFO - Using real prefix '/usr' 17:15:28 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 17:15:29 INFO - Installing distribute.............................................................................................................................................................................................done. 17:15:31 INFO - Installing pip.................done. 17:15:31 INFO - Return code: 0 17:15:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 17:15:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:15:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:15:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:31 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 0x7fe65f963f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17aa850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a93f0>, '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 0x183b560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x183ba10>, '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': '574dc5aafe09851ec43d388c000001b6-1453251771.124468-664606412', '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 17:15:31 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 17:15:31 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 17:15:31 INFO - Using env: {'DISPLAY': ':0', 17:15:31 INFO - 'HOME': '/home/cltbld', 17:15:31 INFO - 'LANG': 'en_US.UTF-8', 17:15:31 INFO - 'LANGUAGE': 'en_US:en', 17:15:31 INFO - 'LOGNAME': 'cltbld', 17:15:31 INFO - 'MAIL': '/var/mail/cltbld', 17:15:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:31 INFO - 'MOZ_NO_REMOTE': '1', 17:15:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:31 INFO - 'NO_EM_RESTART': '1', 17:15:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:15:31 INFO - 'PWD': '/builds/slave/test-pgo', 17:15:31 INFO - 'SHELL': '/bin/bash', 17:15:31 INFO - 'SHLVL': '1', 17:15:31 INFO - 'TERM': 'linux', 17:15:31 INFO - 'TMOUT': '86400', 17:15:31 INFO - 'USER': 'cltbld', 17:15:31 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1453251771.124468-664606412', 17:15:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:31 INFO - '_': '/tools/buildbot/bin/python'} 17:15:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:31 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 17:15:31 INFO - Cleaning up... 17:15:31 INFO - Return code: 0 17:15:31 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 17:15:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:15:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:15:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:31 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 0x7fe65f963f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17aa850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a93f0>, '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 0x183b560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x183ba10>, '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': '574dc5aafe09851ec43d388c000001b6-1453251771.124468-664606412', '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 17:15:31 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 17:15:31 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 17:15:31 INFO - Using env: {'DISPLAY': ':0', 17:15:31 INFO - 'HOME': '/home/cltbld', 17:15:31 INFO - 'LANG': 'en_US.UTF-8', 17:15:31 INFO - 'LANGUAGE': 'en_US:en', 17:15:31 INFO - 'LOGNAME': 'cltbld', 17:15:31 INFO - 'MAIL': '/var/mail/cltbld', 17:15:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:31 INFO - 'MOZ_NO_REMOTE': '1', 17:15:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:31 INFO - 'NO_EM_RESTART': '1', 17:15:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:15:31 INFO - 'PWD': '/builds/slave/test-pgo', 17:15:31 INFO - 'SHELL': '/bin/bash', 17:15:31 INFO - 'SHLVL': '1', 17:15:31 INFO - 'TERM': 'linux', 17:15:31 INFO - 'TMOUT': '86400', 17:15:31 INFO - 'USER': 'cltbld', 17:15:31 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1453251771.124468-664606412', 17:15:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:31 INFO - '_': '/tools/buildbot/bin/python'} 17:15:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:31 INFO - Downloading/unpacking psutil>=0.7.1 17:15:31 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 17:15:31 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 17:15:31 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 17:15:31 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 17:15:31 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 17:15:31 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 17:15:33 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 17:15:33 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 17:15:33 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 17:15:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:15:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:15:33 INFO - Installing collected packages: psutil 17:15:33 INFO - Running setup.py install for psutil 17:15:33 INFO - building 'psutil._psutil_linux' extension 17:15:33 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 17:15:33 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 17:15:33 INFO - building 'psutil._psutil_posix' extension 17:15:33 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 17:15:34 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 17:15:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:15:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:15:34 INFO - Successfully installed psutil 17:15:34 INFO - Cleaning up... 17:15:34 INFO - Return code: 0 17:15:34 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 17:15: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')]} 17:15:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15: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')]} 17:15:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15: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', '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 0x7fe65f963f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17aa850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a93f0>, '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 0x183b560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x183ba10>, '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': '574dc5aafe09851ec43d388c000001b6-1453251771.124468-664606412', '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 17:15: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 17:15: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 mozsystemmonitor==0.0.0 17:15:34 INFO - Using env: {'DISPLAY': ':0', 17:15:34 INFO - 'HOME': '/home/cltbld', 17:15:34 INFO - 'LANG': 'en_US.UTF-8', 17:15:34 INFO - 'LANGUAGE': 'en_US:en', 17:15:34 INFO - 'LOGNAME': 'cltbld', 17:15:34 INFO - 'MAIL': '/var/mail/cltbld', 17:15:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:34 INFO - 'MOZ_NO_REMOTE': '1', 17:15:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:34 INFO - 'NO_EM_RESTART': '1', 17:15:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:15:34 INFO - 'PWD': '/builds/slave/test-pgo', 17:15:34 INFO - 'SHELL': '/bin/bash', 17:15:34 INFO - 'SHLVL': '1', 17:15:34 INFO - 'TERM': 'linux', 17:15:34 INFO - 'TMOUT': '86400', 17:15:34 INFO - 'USER': 'cltbld', 17:15:34 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1453251771.124468-664606412', 17:15:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:34 INFO - '_': '/tools/buildbot/bin/python'} 17:15:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:34 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:15:34 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 17:15:34 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 17:15:34 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 17:15:34 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 17:15:34 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 17:15:34 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 17:15:36 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:15:36 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 17:15:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:15:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:15:36 INFO - Installing collected packages: mozsystemmonitor 17:15:36 INFO - Running setup.py install for mozsystemmonitor 17:15:36 INFO - Successfully installed mozsystemmonitor 17:15:36 INFO - Cleaning up... 17:15:36 INFO - Return code: 0 17:15:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 17:15:36 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')]} 17:15:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:36 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')]} 17:15:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:36 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 0x7fe65f963f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17aa850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a93f0>, '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 0x183b560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x183ba10>, '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': '574dc5aafe09851ec43d388c000001b6-1453251771.124468-664606412', '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 17:15:36 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 17:15:36 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 17:15:36 INFO - Using env: {'DISPLAY': ':0', 17:15:36 INFO - 'HOME': '/home/cltbld', 17:15:36 INFO - 'LANG': 'en_US.UTF-8', 17:15:36 INFO - 'LANGUAGE': 'en_US:en', 17:15:36 INFO - 'LOGNAME': 'cltbld', 17:15:36 INFO - 'MAIL': '/var/mail/cltbld', 17:15:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:36 INFO - 'MOZ_NO_REMOTE': '1', 17:15:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:36 INFO - 'NO_EM_RESTART': '1', 17:15:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:15:36 INFO - 'PWD': '/builds/slave/test-pgo', 17:15:36 INFO - 'SHELL': '/bin/bash', 17:15:36 INFO - 'SHLVL': '1', 17:15:36 INFO - 'TERM': 'linux', 17:15:36 INFO - 'TMOUT': '86400', 17:15:36 INFO - 'USER': 'cltbld', 17:15:36 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1453251771.124468-664606412', 17:15:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:36 INFO - '_': '/tools/buildbot/bin/python'} 17:15:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:36 INFO - Downloading/unpacking blobuploader==1.2.4 17:15:36 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 17:15:36 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 17:15:36 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 17:15:36 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 17:15:36 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 17:15:36 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 17:15:38 INFO - Downloading blobuploader-1.2.4.tar.gz 17:15:38 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 17:15:38 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:15:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:15: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 17:15: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 17:15: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 17:15: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 17:15: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 17:15: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 17:15:38 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 17:15:38 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 17:15:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:15: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 17:15: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 17:15: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 17:15: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 17:15: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 17:15: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 17:15:38 INFO - Downloading docopt-0.6.1.tar.gz 17:15:38 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 17:15:38 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 17:15:38 INFO - Installing collected packages: blobuploader, requests, docopt 17:15:38 INFO - Running setup.py install for blobuploader 17:15:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:15:38 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 17:15:38 INFO - Running setup.py install for requests 17:15:39 INFO - Running setup.py install for docopt 17:15:39 INFO - Successfully installed blobuploader requests docopt 17:15:39 INFO - Cleaning up... 17:15:39 INFO - Return code: 0 17:15:39 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:15:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:15:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:15:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:39 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 0x7fe65f963f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17aa850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a93f0>, '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 0x183b560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x183ba10>, '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': '574dc5aafe09851ec43d388c000001b6-1453251771.124468-664606412', '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 17:15:39 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 17:15:39 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 17:15:39 INFO - Using env: {'DISPLAY': ':0', 17:15:39 INFO - 'HOME': '/home/cltbld', 17:15:39 INFO - 'LANG': 'en_US.UTF-8', 17:15:39 INFO - 'LANGUAGE': 'en_US:en', 17:15:39 INFO - 'LOGNAME': 'cltbld', 17:15:39 INFO - 'MAIL': '/var/mail/cltbld', 17:15:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:39 INFO - 'MOZ_NO_REMOTE': '1', 17:15:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:39 INFO - 'NO_EM_RESTART': '1', 17:15:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:15:39 INFO - 'PWD': '/builds/slave/test-pgo', 17:15:39 INFO - 'SHELL': '/bin/bash', 17:15:39 INFO - 'SHLVL': '1', 17:15:39 INFO - 'TERM': 'linux', 17:15:39 INFO - 'TMOUT': '86400', 17:15:39 INFO - 'USER': 'cltbld', 17:15:39 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1453251771.124468-664606412', 17:15:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:39 INFO - '_': '/tools/buildbot/bin/python'} 17:15:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:15:39 INFO - Running setup.py (path:/tmp/pip-Kj_ZQH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:15:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:15:39 INFO - Running setup.py (path:/tmp/pip-L5F5KA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:15:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:15:39 INFO - Running setup.py (path:/tmp/pip-XnYozo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:15:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:15:39 INFO - Running setup.py (path:/tmp/pip-Ryl620-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:15:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 17:15:39 INFO - Running setup.py (path:/tmp/pip-hNta1W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 17:15:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:15:40 INFO - Running setup.py (path:/tmp/pip-fjt6bo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:15:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:15:40 INFO - Running setup.py (path:/tmp/pip-FunS4H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:15:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:15:40 INFO - Running setup.py (path:/tmp/pip-Tm_3wf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:15:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 17:15:40 INFO - Running setup.py (path:/tmp/pip-cGBLX_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 17:15:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 17:15:40 INFO - Running setup.py (path:/tmp/pip-3wsQpj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 17:15:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:15:40 INFO - Running setup.py (path:/tmp/pip-X3r7y2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:15:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:15:40 INFO - Running setup.py (path:/tmp/pip-LVMHoo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:15:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:15:40 INFO - Running setup.py (path:/tmp/pip-05pSUH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:15:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:15:40 INFO - Running setup.py (path:/tmp/pip-PucUu5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:15:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:15:40 INFO - Running setup.py (path:/tmp/pip-Vb57I2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:15:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 17:15:40 INFO - Running setup.py (path:/tmp/pip-HjZIlr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 17:15:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 17:15:40 INFO - Running setup.py (path:/tmp/pip-ZUnjYC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 17:15:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:15:40 INFO - Running setup.py install for manifestparser 17:15:40 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 17:15:41 INFO - Running setup.py install for mozcrash 17:15:41 INFO - Running setup.py install for mozdebug 17:15:41 INFO - Running setup.py install for mozdevice 17:15:41 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 17:15:41 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 17:15:41 INFO - Running setup.py install for mozfile 17:15:41 INFO - Running setup.py install for mozhttpd 17:15:41 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 17:15:41 INFO - Running setup.py install for mozinfo 17:15:41 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 17:15:41 INFO - Running setup.py install for mozInstall 17:15:41 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 17:15:41 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 17:15:41 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 17:15:41 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 17:15:41 INFO - Running setup.py install for mozleak 17:15:41 INFO - Running setup.py install for mozlog 17:15:41 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 17:15:41 INFO - Running setup.py install for moznetwork 17:15:42 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 17:15:42 INFO - Running setup.py install for mozprocess 17:15:42 INFO - Running setup.py install for mozprofile 17:15:42 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 17:15:42 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 17:15:42 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 17:15:42 INFO - Running setup.py install for mozrunner 17:15:42 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 17:15:42 INFO - Running setup.py install for mozscreenshot 17:15:42 INFO - Running setup.py install for moztest 17:15:42 INFO - Running setup.py install for mozversion 17:15:42 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 17:15:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:15:42 INFO - Cleaning up... 17:15:42 INFO - Return code: 0 17:15:42 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:15:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:15:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:15:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:42 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 0x7fe65f963f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17aa850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a93f0>, '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 0x183b560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x183ba10>, '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': '574dc5aafe09851ec43d388c000001b6-1453251771.124468-664606412', '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 17:15:42 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 17:15:42 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 17:15:42 INFO - Using env: {'DISPLAY': ':0', 17:15:42 INFO - 'HOME': '/home/cltbld', 17:15:42 INFO - 'LANG': 'en_US.UTF-8', 17:15:42 INFO - 'LANGUAGE': 'en_US:en', 17:15:42 INFO - 'LOGNAME': 'cltbld', 17:15:42 INFO - 'MAIL': '/var/mail/cltbld', 17:15:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:42 INFO - 'MOZ_NO_REMOTE': '1', 17:15:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:42 INFO - 'NO_EM_RESTART': '1', 17:15:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:15:42 INFO - 'PWD': '/builds/slave/test-pgo', 17:15:42 INFO - 'SHELL': '/bin/bash', 17:15:42 INFO - 'SHLVL': '1', 17:15:42 INFO - 'TERM': 'linux', 17:15:42 INFO - 'TMOUT': '86400', 17:15:42 INFO - 'USER': 'cltbld', 17:15:42 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1453251771.124468-664606412', 17:15:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:42 INFO - '_': '/tools/buildbot/bin/python'} 17:15:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:15:42 INFO - Running setup.py (path:/tmp/pip-GwYjiW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:15:42 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)) 17:15:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:15:42 INFO - Running setup.py (path:/tmp/pip-MjEFtb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:15:43 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)) 17:15:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:15:43 INFO - Running setup.py (path:/tmp/pip-N3qpup-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:15:43 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)) 17:15:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:15:43 INFO - Running setup.py (path:/tmp/pip-_B9B_x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:15:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 17:15:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 17:15:43 INFO - Running setup.py (path:/tmp/pip-r0anmV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 17:15:43 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)) 17:15:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:15:43 INFO - Running setup.py (path:/tmp/pip-_OmUog-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:15:43 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)) 17:15:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:15:43 INFO - Running setup.py (path:/tmp/pip-NsqN9G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:15:43 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)) 17:15:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:15:43 INFO - Running setup.py (path:/tmp/pip-ZEyeku-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:15:43 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)) 17:15:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 17:15:43 INFO - Running setup.py (path:/tmp/pip-4PRZH1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 17:15:43 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)) 17:15:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 17:15:43 INFO - Running setup.py (path:/tmp/pip-noOskb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 17:15:43 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)) 17:15:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:15:43 INFO - Running setup.py (path:/tmp/pip-vCwVul-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:15:43 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)) 17:15:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:15:43 INFO - Running setup.py (path:/tmp/pip-LjM4eK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:15:43 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)) 17:15:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:15:43 INFO - Running setup.py (path:/tmp/pip-S883A6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:15:43 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)) 17:15:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:15:43 INFO - Running setup.py (path:/tmp/pip-lVGiqr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:15:43 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)) 17:15:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:15:43 INFO - Running setup.py (path:/tmp/pip-QBqfvY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:15:43 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)) 17:15:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 17:15:43 INFO - Running setup.py (path:/tmp/pip-y2ycUb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 17:15:44 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)) 17:15:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 17:15:44 INFO - Running setup.py (path:/tmp/pip-alpvRG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 17:15:44 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)) 17:15:44 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)) 17:15:44 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)) 17:15:44 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)) 17:15:44 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.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 17:15:44 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.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 17:15:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 17:15:44 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 17:15:44 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 17:15:44 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 17:15:44 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 17:15:44 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 17:15:44 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 17:15:45 INFO - Downloading blessings-1.5.1.tar.gz 17:15:45 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 17:15:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 17:15:45 INFO - Installing collected packages: blessings 17:15:45 INFO - Running setup.py install for blessings 17:15:45 INFO - Successfully installed blessings 17:15:45 INFO - Cleaning up... 17:15:46 INFO - Return code: 0 17:15:46 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 17:15:46 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 17:15:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 17:15:46 INFO - Reading from file tmpfile_stdout 17:15:46 INFO - Current package versions: 17:15:46 INFO - argparse == 1.2.1 17:15:46 INFO - blessings == 1.5.1 17:15:46 INFO - blobuploader == 1.2.4 17:15:46 INFO - docopt == 0.6.1 17:15:46 INFO - manifestparser == 1.1 17:15:46 INFO - mozInstall == 1.12 17:15:46 INFO - mozcrash == 0.16 17:15:46 INFO - mozdebug == 0.1 17:15:46 INFO - mozdevice == 0.48 17:15:46 INFO - mozfile == 1.2 17:15:46 INFO - mozhttpd == 0.7 17:15:46 INFO - mozinfo == 0.9 17:15:46 INFO - mozleak == 0.1 17:15:46 INFO - mozlog == 3.1 17:15:46 INFO - moznetwork == 0.27 17:15:46 INFO - mozprocess == 0.22 17:15:46 INFO - mozprofile == 0.28 17:15:46 INFO - mozrunner == 6.11 17:15:46 INFO - mozscreenshot == 0.1 17:15:46 INFO - mozsystemmonitor == 0.0 17:15:46 INFO - moztest == 0.7 17:15:46 INFO - mozversion == 1.4 17:15:46 INFO - psutil == 3.1.1 17:15:46 INFO - requests == 1.2.3 17:15:46 INFO - wsgiref == 0.1.2 17:15:46 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:15: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')]} 17:15:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15: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')]} 17:15:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15: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/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 0x7fe65f963f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17aa850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a93f0>, '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 0x183b560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x183ba10>, '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': '574dc5aafe09851ec43d388c000001b6-1453251771.124468-664606412', '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 17:15: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/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 17:15: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/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 17:15:46 INFO - Using env: {'DISPLAY': ':0', 17:15:46 INFO - 'HOME': '/home/cltbld', 17:15:46 INFO - 'LANG': 'en_US.UTF-8', 17:15:46 INFO - 'LANGUAGE': 'en_US:en', 17:15:46 INFO - 'LOGNAME': 'cltbld', 17:15:46 INFO - 'MAIL': '/var/mail/cltbld', 17:15:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:46 INFO - 'MOZ_NO_REMOTE': '1', 17:15:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:46 INFO - 'NO_EM_RESTART': '1', 17:15:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:15:46 INFO - 'PWD': '/builds/slave/test-pgo', 17:15:46 INFO - 'SHELL': '/bin/bash', 17:15:46 INFO - 'SHLVL': '1', 17:15:46 INFO - 'TERM': 'linux', 17:15:46 INFO - 'TMOUT': '86400', 17:15:46 INFO - 'USER': 'cltbld', 17:15:46 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1453251771.124468-664606412', 17:15:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:46 INFO - '_': '/tools/buildbot/bin/python'} 17:15:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:46 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)) 17:15:46 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)) 17:15:46 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)) 17:15:46 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)) 17:15:46 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)) 17:15:46 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)) 17:15:46 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)) 17:15:46 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)) 17:15:46 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)) 17:15:46 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)) 17:15:46 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)) 17:15:46 INFO - Cleaning up... 17:15:46 INFO - Return code: 0 17:15:46 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 17:15: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')]} 17:15:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15: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')]} 17:15:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15: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', '--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 0x7fe65f963f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17aa850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a93f0>, '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 0x183b560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x183ba10>, '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': '574dc5aafe09851ec43d388c000001b6-1453251771.124468-664606412', '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 17:15:46 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 17:15:46 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 17:15:46 INFO - Using env: {'DISPLAY': ':0', 17:15:46 INFO - 'HOME': '/home/cltbld', 17:15:46 INFO - 'LANG': 'en_US.UTF-8', 17:15:46 INFO - 'LANGUAGE': 'en_US:en', 17:15:46 INFO - 'LOGNAME': 'cltbld', 17:15:46 INFO - 'MAIL': '/var/mail/cltbld', 17:15:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:46 INFO - 'MOZ_NO_REMOTE': '1', 17:15:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:46 INFO - 'NO_EM_RESTART': '1', 17:15:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:15:46 INFO - 'PWD': '/builds/slave/test-pgo', 17:15:46 INFO - 'SHELL': '/bin/bash', 17:15:46 INFO - 'SHLVL': '1', 17:15:46 INFO - 'TERM': 'linux', 17:15:46 INFO - 'TMOUT': '86400', 17:15:46 INFO - 'USER': 'cltbld', 17:15:46 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1453251771.124468-664606412', 17:15:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:46 INFO - '_': '/tools/buildbot/bin/python'} 17:15:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:46 INFO - Downloading/unpacking jsonschema 17:15:46 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 17:15:46 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 17:15:46 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 17:15:46 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 17:15:46 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 17:15:46 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 17:15:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:15:48 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 17:15:48 INFO - Downloading/unpacking functools32 (from jsonschema) 17:15: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 17:15: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 17:15: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 17:15: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 17:15: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 17:15: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 17:15:48 INFO - Downloading functools32-3.2.3-2.tar.gz 17:15:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 17:15:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 17:15:48 INFO - warning: no files found matching '*.txt' 17:15:48 INFO - no previously-included directories found matching 'build' 17:15:48 INFO - no previously-included directories found matching 'dist' 17:15:48 INFO - no previously-included directories found matching '.git*' 17:15:48 INFO - Installing collected packages: jsonschema, functools32 17:15:48 INFO - Running setup.py install for functools32 17:15:48 INFO - warning: no files found matching '*.txt' 17:15:48 INFO - no previously-included directories found matching 'build' 17:15:48 INFO - no previously-included directories found matching 'dist' 17:15:48 INFO - no previously-included directories found matching '.git*' 17:15:48 INFO - Successfully installed jsonschema functools32 17:15:48 INFO - Cleaning up... 17:15:48 INFO - Return code: 0 17:15:48 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 17:15:48 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')]} 17:15:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:48 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')]} 17:15:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:48 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 0x7fe65f963f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17aa850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a93f0>, '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 0x183b560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x183ba10>, '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': '574dc5aafe09851ec43d388c000001b6-1453251771.124468-664606412', '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 17:15:48 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 17:15:48 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 17:15:48 INFO - Using env: {'DISPLAY': ':0', 17:15:48 INFO - 'HOME': '/home/cltbld', 17:15:48 INFO - 'LANG': 'en_US.UTF-8', 17:15:48 INFO - 'LANGUAGE': 'en_US:en', 17:15:48 INFO - 'LOGNAME': 'cltbld', 17:15:48 INFO - 'MAIL': '/var/mail/cltbld', 17:15:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:48 INFO - 'MOZ_NO_REMOTE': '1', 17:15:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:48 INFO - 'NO_EM_RESTART': '1', 17:15:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:15:48 INFO - 'PWD': '/builds/slave/test-pgo', 17:15:48 INFO - 'SHELL': '/bin/bash', 17:15:48 INFO - 'SHLVL': '1', 17:15:48 INFO - 'TERM': 'linux', 17:15:48 INFO - 'TMOUT': '86400', 17:15:48 INFO - 'USER': 'cltbld', 17:15:48 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1453251771.124468-664606412', 17:15:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:48 INFO - '_': '/tools/buildbot/bin/python'} 17:15:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:49 INFO - Downloading/unpacking flake8 17:15:49 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 17:15:49 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 17:15:49 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 17:15:49 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 17:15:49 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 17:15:49 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 17:15:50 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:15:50 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 17:15:50 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:15: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 17:15: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 17:15: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 17:15: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 17:15: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 17:15: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 17:15:51 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:15:51 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 17:15:51 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:15:51 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 17:15:51 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 17:15:51 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 17:15:51 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 17:15:51 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 17:15:51 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 17:15:51 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 17:15:51 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:15:51 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 17:15:51 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 17:15:51 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 17:15:51 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 17:15:51 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 17:15:51 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 17:15:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 17:15:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 17:15:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:15:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:15:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:15:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:15:51 INFO - no previously-included directories found matching 'docs/_build' 17:15:51 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:15:51 INFO - Running setup.py install for pep8 17:15:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:15:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:15:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:15:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:15:51 INFO - no previously-included directories found matching 'docs/_build' 17:15:51 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 17:15:51 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:15:51 INFO - Cleaning up... 17:15:51 INFO - Return code: 0 17:15:51 INFO - Running post-action listener: _resource_record_post_action 17:15:51 INFO - Running post-action listener: _start_resource_monitoring 17:15:51 INFO - Starting resource monitoring. 17:15:51 INFO - ##### 17:15:51 INFO - ##### Running install step. 17:15:51 INFO - ##### 17:15:51 INFO - Running pre-action listener: _resource_record_pre_action 17:15:51 INFO - Running main action method: install 17:15:51 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 17:15:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 17:15:51 INFO - Reading from file tmpfile_stdout 17:15:51 INFO - Detecting whether we're running mozinstall >=1.0... 17:15:51 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 17:15:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 17:15:52 INFO - Reading from file tmpfile_stdout 17:15:52 INFO - Output received: 17:15:52 INFO - Usage: mozinstall [options] installer 17:15:52 INFO - Options: 17:15:52 INFO - -h, --help show this help message and exit 17:15:52 INFO - -d DEST, --destination=DEST 17:15:52 INFO - Directory to install application into. [default: 17:15:52 INFO - "/builds/slave/test-pgo"] 17:15:52 INFO - --app=APP Application being installed. [default: firefox] 17:15:52 INFO - mkdir: /builds/slave/test-pgo/build/application 17:15:52 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'] 17:15:52 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 17:16:08 INFO - Reading from file tmpfile_stdout 17:16:08 INFO - Output received: 17:16:08 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 17:16:08 INFO - Running post-action listener: _resource_record_post_action 17:16:08 INFO - ##### 17:16:08 INFO - ##### Running run-tests step. 17:16:08 INFO - ##### 17:16:08 INFO - Running pre-action listener: _resource_record_pre_action 17:16:08 INFO - Running main action method: run_tests 17:16:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 17:16:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 17:16:08 INFO - Python 2.7.3 17:16:08 INFO - Return code: 0 17:16:08 INFO - grabbing minidump binary from tooltool 17:16:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:16:08 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 0x17a93f0>, '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 0x183b560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x183ba10>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 17:16:08 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 17:16:08 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 17:16:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:16:08 INFO - Return code: 0 17:16:08 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 17:16:08 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 17:16:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 17:16:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 17:16:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 17:16:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 17:16:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 17:16:09 INFO - Return code: 0 17:16:09 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-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FD2urM-AT6an-vdyRR3ocQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 17:16:09 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-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FD2urM-AT6an-vdyRR3ocQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-044 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 17:16:09 INFO - Using env: {'DISPLAY': ':0', 17:16:09 INFO - 'HOME': '/home/cltbld', 17:16:09 INFO - 'LANG': 'en_US.UTF-8', 17:16:09 INFO - 'LANGUAGE': 'en_US:en', 17:16:09 INFO - 'LOGNAME': 'cltbld', 17:16:09 INFO - 'MAIL': '/var/mail/cltbld', 17:16:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 17:16:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 17:16:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:09 INFO - 'MOZ_NO_REMOTE': '1', 17:16:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 17:16:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:16:09 INFO - 'NO_EM_RESTART': '1', 17:16:09 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:16:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:16:09 INFO - 'PWD': '/builds/slave/test-pgo', 17:16:09 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 17:16:09 INFO - 'SHELL': '/bin/bash', 17:16:09 INFO - 'SHLVL': '1', 17:16:09 INFO - 'TERM': 'linux', 17:16:09 INFO - 'TMOUT': '86400', 17:16:09 INFO - 'USER': 'cltbld', 17:16:09 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1453251771.124468-664606412', 17:16:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:09 INFO - '_': '/tools/buildbot/bin/python'} 17:16:09 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-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FD2urM-AT6an-vdyRR3ocQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 17:16:09 INFO - mozversion application_buildid: 20160119143009 17:16:09 INFO - mozversion application_changeset: 48e077b052981e34081e4b8158678fee4f52e88c 17:16:09 INFO - mozversion application_display_name: Nightly 17:16:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:16:09 INFO - mozversion application_name: Firefox 17:16:09 INFO - mozversion application_remotingname: firefox 17:16:09 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:16:09 INFO - mozversion application_vendor: Mozilla 17:16:09 INFO - mozversion application_version: 46.0a1 17:16:09 INFO - mozversion platform_buildid: 20160119143009 17:16:09 INFO - mozversion platform_changeset: 48e077b052981e34081e4b8158678fee4f52e88c 17:16:09 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:16:09 INFO - mozversion platform_version: 46.0a1 17:16:09 INFO - using testdate: 1453252569 17:16:09 INFO - actual date: 1453252569 17:16:09 INFO - starting webserver on 'localhost:48299' 17:16:09 INFO - SUITE-START | Running 3 tests 17:16:09 INFO - TEST-START | dromaeo_css 17:16:09 INFO - operating with platform_type : linux_ 17:16:09 INFO - Initialising browser for dromaeo_css test... 17:16:09 INFO - TEST-INFO | started process 12653 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYbEWyQ/profile http://localhost:48299/getInfo.html) 17:16:12 INFO - PROCESS | 12653 | 17:16:12 INFO - PROCESS | 12653 | (process:12739): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:16:13 INFO - PROCESS | 12653 | __metrics Screen width/height:1600/1200 17:16:13 INFO - PROCESS | 12653 | colorDepth:24 17:16:13 INFO - PROCESS | 12653 | Browser inner width/height: 1024/697 17:16:13 INFO - PROCESS | 12653 | __metrics 17:16:13 INFO - PROCESS | 12653 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:16:14 INFO - TEST-INFO | 12653: exit 0 17:16:14 INFO - Browser initialized. 17:16:14 INFO - Running cycle 1/1 for dromaeo_css test... 17:16:14 INFO - TEST-INFO | started process 12788 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYbEWyQ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:16:15 INFO - PROCESS | 12788 | -- checkerboarding starts below -- 17:16:15 INFO - PROCESS | 12788 | RENDERTRACE 0.077576 rect red 0 0 10 10 // viewport 17:16:15 INFO - PROCESS | 12788 | RENDERTRACE 12.5504 rect brown 0 0 10 10 // page 17:16:15 INFO - PROCESS | 12788 | RENDERTRACE 12.5732 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 17:16:15 INFO - PROCESS | 12788 | Checkerboarded for 1 frames (12.6168 ms), 100 peak, 1 severity. 17:16:16 INFO - PROCESS | 12788 | 17:16:16 INFO - PROCESS | 12788 | (process:12845): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:16:26 INFO - PROCESS | 12788 | RSS: Main: 150802432 17:16:26 INFO - PROCESS | 12788 | 17:17:16 INFO - PROCESS | 12788 | 1453252636248 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] 17:19:25 INFO - PROCESS | 12788 | Cycle 1(1): loaded http://localhost:48299/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48299/tests/dromaeo/cssquery-ext.html) 17:19:26 INFO - PROCESS | 12788 | RSS: Main: 155459584 17:19:26 INFO - PROCESS | 12788 | 17:22:28 INFO - PROCESS | 12788 | Cycle 1(1): loaded http://localhost:48299/tests/dromaeo/cssquery-ext.html (next: http://localhost:48299/tests/dromaeo/cssquery-jquery.html) 17:22:28 INFO - PROCESS | 12788 | RSS: Main: 151896064 17:22:28 INFO - PROCESS | 12788 | 17:25:30 INFO - PROCESS | 12788 | Cycle 1(1): loaded http://localhost:48299/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48299/tests/dromaeo/cssquery-mootools.html) 17:25:31 INFO - PROCESS | 12788 | RSS: Main: 151179264 17:25:31 INFO - PROCESS | 12788 | 17:28:33 INFO - PROCESS | 12788 | Cycle 1(1): loaded http://localhost:48299/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48299/tests/dromaeo/cssquery-prototype.html) 17:28:33 INFO - PROCESS | 12788 | RSS: Main: 150278144 17:28:33 INFO - PROCESS | 12788 | 17:31:36 INFO - PROCESS | 12788 | Cycle 1(1): loaded http://localhost:48299/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48299/tests/dromaeo/cssquery-yui.html) 17:31:36 INFO - PROCESS | 12788 | RSS: Main: 150626304 17:31:36 INFO - PROCESS | 12788 | 17:34:39 INFO - PROCESS | 12788 | Cycle 1(1): loaded http://localhost:48299/tests/dromaeo/cssquery-yui.html (next: http://localhost:48299/tests/dromaeo/cssquery-dojo.html) 17:34:39 INFO - PROCESS | 12788 | RSS: Main: 153161728 17:34:39 INFO - PROCESS | 12788 | 17:34:39 INFO - PROCESS | 12788 | __start_tp_report 17:34:39 INFO - PROCESS | 12788 | _x_x_mozilla_page_load 17:34:39 INFO - PROCESS | 12788 | _x_x_mozilla_page_load_details 17:34:39 INFO - PROCESS | 12788 | |i|pagename|runs| 17:34:39 INFO - PROCESS | 12788 | |0;dojo.html;3196.3607278544296;3208.4545627243365;3231.2406584452665;3247.2206670399105;3279.7376209903196;5216.26972223888;5243.16109422493;5262.473752624735;5282.2076688496745;5294.444083371249;5236.057509648262;5263.894722105565;5293.814716484924;5295.523402893738;5360.356757189143;4776.044791041788;4804.615630749532;4813.061453016663;4883.9511604883855;4913.9189378336705;4549.454065512126;4867.1482490564185;4874.53691899269;4935.259711043354;4939.506049395068;4700.224462963607;4731.69243999139;4808.759562021885;4829.686070405448;4863.17326054568;4746.1931471649905;4761;4771.045790841846;4799.3760811094335;4808.711477311337;4697.976510117462;4729.432468103815;4741.739204343759;4757.215059515176;4775.498572649891;5121.28302037715;5139.9229011564485;5140.306058682105;5178.715170665612;5181.481851814826;5585.776568937237;5587.916181257285;5681.261436013292;5690.573207009449;5754.136879468071;5685.602007859451;5758.510526605243;5764.769409223626;5769;5773.711314434261;5275.788968441258;5365.409804921455;5394.973025134849;5396.352437707461;5407.107827208506;5827.533797296206;5827.883442331215;5860.208871802252;5860.560457965669;5901.232839730807;5541;5623.831285061455;5643.40744221859;5651.095824668116;5667.489925906688;5562.443755624405;5612.719364031864;5678.119891416837;5714.685692286964;5753.194552762617;5752.511036561856;5753.884922301614;5757.309122905278;5769.451902069297;5778.27771528559;5728.971355143198;5757.539396848242;5764.654120752768;5765.250517432707;5766.336871259775;4291.806868690854;4376.277914144194;4414.646828253732;4448.888777780581;4495.145922274757;3912.550056743454;3915.1778126593736;3921.8431262749173;3970.1265721541213;3976.165005348851;5265.631405801557;5279.234510995961;5280.102382594968;5290.523852853262;5299.6025298102795;5638.774449021993;5672.773089076473;5728.255326807488;5792.79725209624;5878;5286.101362768339;5304.310439642822;5311.070562651521;5313.840584782385;5322.467753224724;4823.300621409876;4846.466888642247;4847.418309802846;4856.271559266138;4890.339804126468;5765.423457654201;5782.624129431573;5820.447057529528;5851.736671849691;5856.619319744203;5635.633683810539;5654.40628733977;5688.459596338341;5693.772249109989;5728.570357223308;5890.057590785454;5901.409859014064;5920.230370052038;5934.3175534814045;5934.554908381975;5506.1190209566275;5532.004239236976;5658.9151162733415;5680.801171959127;5725.513331366714;5717.628354156966;5729.799457018984;5730.08318669011;5763.193152958505;5763.510101641407;5611.046122159324;5639.577031722555;5645.181448689835;5650.689212093374;5656.971715141398;5454.10007348783;5467.988422141916;5523.7790488380015;5543.3902270751;5579.972100139474;5466.125419932791;5532.446755324436;5538.6399884007415;5565.332160140809;5566.97216513931;5609.4390560943575;5634.802781902614;5653.830385088454;5657.745401456862;5682.261306030189;5409.215663728816;5452.291202143696;5488.149336852634;5512.3660779010925;5536.141898005815 17:34:39 INFO - PROCESS | 12788 | |1;ext.html;543.4402565357683;560.179337270898;584.7134903897091;598.6378241164095;598.6467983889505;36639.81680091599;37130.62869371302;37150.442743358806;37260.44109338359;37393.81303093488;43940.78029609848;44554.77722611382;44597.55402445982;44713.776431117796;44807.551924480824;8549;8819.426737262089;8841.425307355034;8862.24670902974;8865.468071915673;8572.785680357978;8582.570871456433;8614;8658.826823463527;8678.86981695275;8586.22723954844;8587.699430519933;8674.436161649504;8722.563871806417;8741.038485766561;8661.523616201106;8662.87005694915;8678.956605216934;8740.562971851414;8750.86873696892;8472.19514146155;8600.784980375478;8606.053334133303;8606.35452341077;8611.48331100136;41100.79449602763;41202.175956481005;41247;41548.584514155074;41671;2649.894004239828;3121.2352973521406;3167.857446414917;3178.126015345775;3391.4573668212965;26308.473830523475;26669.73330266711;27074.593881091798;27178;27381.589276160874;3492.6158122606494;3710.035390798385;3816.618338166189;3871.322518559269;3871.535415750128;184406;185530;185657;185991;186058;53448.465515345124;54577.181342279895;56348.71825640846;56662.71668641713;62101.37898621046;54375.18437223445;54554.45445545573;54866.451335486134;54943.17585236225;55033.724831375584;13862.93068534651;14002.649933751738;14033.438662453591;14040.297985100704;14040.71918561623;9841.261905357127;9938.254630902567;9941.850872236922;9954.751131221632;9970.750731231778;20271.4932126698;20337;20350.898245508677;20483.795162048187;20653.690194647093;7615;7663.885041724378;7771.961140194263;7783;7828.569428681477;861.5261606116611;939.3706216834737;955.6655170690342;998.1266391907081;1028.7325295423095;28767;29031.70968290332;29176.416471670447;29376.26559336034;29743.25641858971;997.0179373317277;1026.3482688492861;1100.3837850803575;1145.7422080031927;1176.04152615618;15145.311916324243;15204.771928421083;15225.6193595161;15275.618109547127;15334.156621385708;321681;322264;324518;325741;328538;53344;53424;53476.465235347925;53545.46454535483;53718.46281537135;1274.6494713953552;1287.4270949427603;1294.643972907458;1304.9739005219842;1305.1386085183733;28170.577441337988;29024;29209.707902920698;29214;29264.26839329034;47175;47478.287825683336;47484;47530.28704569365;47559.76842547248;240346;240959;241079;241750;242573.57426426216;33105.83447082749;33612.327753445286;33818.830905845316;33861.32277354488;33964;38176.236475270896;38369.61630383661;39011.6098839008;39878.2024359517;42905.57094429016;35466.46800297946;35674.28651426905;35681.82159089188;35714.28571428505;35931.820340899176;35751.46372804358;35848.283034338645;35887;35987.46018809667;38404;35150.29699405946;35616.287674245854;35922.28155436929;36311.09222269359;36368;30520.542191866694;31880.521792172673;32823.34353312968;32839.34321313513;33103;24957.75042249627;25271.368215794017;25308.746912530638;25339.128013366484;25365.239042828744 17:34:39 INFO - PROCESS | 12788 | |2;jquery.html;366.23639711202145;367.1885133854183;367.97240206984463;368.29839156407047;375.1802311948391;15831.762523562142;16984.32062717493;17454.301827926884;17673.7348939766;18485.44543663689;10334.121599664037;10486.011486726284;14918.776218356734;14970.775438368433;15037.248137593131;5049.318342023835;5239.895202095956;5652.745626446799;5657.23627310314;5668.829935101953;4548.363229147905;5528.419515950827;5602.1596760485845;5606.046972014747;5624.803131890385;5093.847184584469;5307.601929855257;5308.946910530904;5425.891482170354;5510.779568817243;5153.613478989091;5196.324477817879;5196.480351964811;5221.947780522203;5440.374356948962;5255.343082114736;5257.5005374489365;5262.657927234755;5268.710220937847;5275.683458992473;13556.728865422636;19842;20438.284660036978;20459.2839250627;20800;1854.2387220383714;1870.8129187081183;1903.5146037760283;1984.9932126359229;2006.8695534790338;8994.505302208376;9344.15902568772;9640.276979226515;10008.149307308888;11530.308181509135;1803.7474753534516;1835.6420498002894;1835.715464103053;1838.980237898243;1870.5043163561668;55747.72126139384;57453.425465745226;57462.71268643672;57727.42272577262;59135.40864591342;10242.334248273839;10258.487075646188;10302.639407620698;10310.742231444274;10341.069303762548;13263.336833158304;13408.664783380493;13414.932925335506;13421.39603717835;13545;6916.792496225121;6993.545419547815;7022.92977070233;7072.292770722886;7092.113485814273;6508.446782023581;6523.902141467882;6538.1500404947055;6555.115059466911;6659.567128136656;4420.336949457543;4536.4102666653125;4554.63562914966;4571.222892108283;4580.954190458119;1762.9382971595933;1780.8130146334706;1838.2737771840887;1843.511469460594;1847.3466247708227;437.7154849347949;437.75485727992424;846.7713717296418;922.820050090226;972.6984634763246;9966.750831229132;10776.19178561611;10860.61987830438;10987.835182472269;11238.66284011481;419.42329297216327;427.57029185668205;429.2852400752774;442.5353378952087;451.6793076915361;5664.405237450091;5677.829665110054;5730.7421166047625;9629.229661627052;9968.35205711641;512133;514751;527299;529154;529911;73918.63040684762;76265.61867190628;76436.85344719833;77033;77576;1148.655403378983;1154.9364784936909;1166.1836714300193;1174.5477990973366;1188.8632807227107;15105.32026058808;15290.617734556725;15493.380264789283;15529.378824847332;15828;34872.65127348796;34890.99999999898;35194.47208291826;35739.82130089333;35775.28449431049;45202.77398612986;45648.54351456443;45865.312020319056;46171.07657846757;46737.76631116823;7350.19147893742;7501.699932002659;7547.132079810892;7656.578888161204;7701.191374905554;10766.084882785051;11235.887641123483;11382.601608943978;11439.256448330832;11527.365994870363;7392.309141944695;8066.878996814935;8919.687810926587;9684.56419461112;9809.705708828747;9366.250699943852;9495.24038076966;9636.662716804878;9966.700998970042;10273;9350.392224505385;9408.905910941077;9418.058194180801;9641.951790241004;10021.198304135798;7326.890096648661;7363.889541656772;7380.225076366904;7467.327940485382;7468.4398670101045;8539.359548034046;9868.210543156387;9937.900620993987;10015.649452269136;10120.392776433437 17:34:39 INFO - PROCESS | 12788 | |3;mootools.html;1475.2844870237936;1498.4980031689383;1666.1003058348492;1795.4254638515663;1822.1071674879304;7809.492382995101;7910.208979102102;7947.523148611087;7972.880406793895;8043.235892590209;8080.272775450208;8117.512949223051;8175.91824081759;8187.877181842277;8200.835983280345;2370.715514138306;2383.9404014899637;2387.092904696213;2389.761023897605;2400.147947478646;2407.277816655005;2422.2854257993845;2429.5748244057218;2431.258466167818;2432.7567243275707;2319.1535089692225;2371.4308565944134;2372.6678265042906;2383.618621020637;2404.362843846382;2359.9174028908906;2384.725756537994;2416.1060407649106;2418.056957786465;2419.129113519132;2396.940076498084;2422.551827911824;2434.184548176363;2434.6469761884605;2436.317831007321;7979.56112413817;8062.637181326854;8068.193180681944;8094.109647938722;8109.229623185788;4720.622350212009;4827.155247831651;4830.178869592178;4857.878553036167;4882.218844984821;3182.0931034655246;3187.3147273336112;3217.469117595594;3233.143217047484;3273.427150248721;1042.6142327338932;1055.134789472625;1083.9891601083966;1113.8050841102774;1123.9044681202108;10871.184661150446;10936.179786515964;10989.285696429706;11016.17378696593;11115.777684446266;4355.1725172217175;4360.716553424018;4468.932966005513;4517.299818528133;4548.931766023512;8635.30917526609;8663.35024873137;8683.435576687496;8694.956525217334;8698.260647844878;4881.096997055556;4888.364512613338;4891.144049791273;4905.632077594195;4919.409670839522;4406.272964960745;4421.756803375781;4430.889227769331;4432.512423633398;4467.195904737114;3567.5897271813556;3574.588922273972;3586.1393265616066;3600.9459858101627;3612.2414292998237;1100.5157730598512;1111.105560024172;1147.2886810177743;1153.348358177627;1162.505934977648;1035.7151783259665;1059.21618002679;1062.293574772783;1173.8884805943421;1314.5990472905855;7117.395021423134;7120.074390329328;7150.10623672041;7214.603196824225;7258.891116633255;1117.6982214801958;1140.1676775953435;1143.5482984221187;1146.850909381775;1149.3104137517423;5774.393688662714;5933.436323549256;5959.702014899324;6016.669083200379;6018.067199583984;9209.769755756026;9380.437173769596;9390.5304734763;9572.234221262283;9647.517624118766;9358.953205233931;9365.11031452011;9408.764780880532;9446;9457.668981585612;7194.496385253086;7246.021787058785;7290.161631412349;7294.051773269441;7378.557286562824;7390.482666213314;7419.703211871465;7452.441066919894;7485.251474852689;7526.5107767994905;8280.83438331218;8509.74470765878;8557.957210213908;8618.741437756877;8683.869741954002;8532.23209911111;8663.39356245082;8693.30453563726;8710.99823520278;8731;7167.498275120692;7292.744753933587;7296.854062918605;7304.342609165201;7327.303906129123;7587.962060189884;7605.695772169051;7635.961820190863;7641.159472457914;7672;6399.936000639934;7379.114506259283;7398.852022959618;7428.962855185906;7513;6270.529710271657;7105.32499412555;7149.714011439484;7213.062301900719;7278.381337586365;7071.929280707127;7088.184858741311;7095.46783991213;7101.360877520841;7109.928900710926;6585.407313341822;6588.505862060269;6614.239362473377;6649.966750166218;6656.83357916056;6563.803085907431;6629.071929929717;6647.534672572873;6746.392824645805;6835.21395039557 17:34:39 INFO - PROCESS | 12788 | |4;prototype.html;339.9218179818642;343.71643394199793;344.42824910648346;346.6810534308436;351.6852417086707;6150.708351246244;6252.937470625292;6272.874542509147;6273.215848018997;6376.744930202786;6069;6191.535634827384;6225;6242.625442473443;6247.0317100849325;4859.562639362457;4860.513948605147;4864.708117512961;4865.732384718848;4868.9269660955115;4862.6839255448285;4870.975645121769;4875.341828853113;4877.097736918664;4879.536444037829;4736.005438857844;4792.83225087122;4812.590929770956;4813.518648135194;4829.106615276168;4764.499727528594;4797.568218860302;4803.663743537953;4804.519548045202;4819.49395313494;4166.562510936338;4231.1114665920195;4234.280172370704;4249.46881639795;4266.1467706458525;5945.078512830518;5948.553858460589;5969.283685957713;5970.492508136814;5998.730057147395;5496.340439147288;5639.351474580435;5641.5204707599905;5648.604597678164;5649.548036157139;6661.500387470959;6662.966685166592;6670.83322916931;6674.299198584175;6689.8662026759675;4709.034647897173;4710.9764451177525;4718.716876987358;4719.882002949919;4724.5039270876405;6735.797926062177;6980.616066116361;6983.12710911131;6984.720611175547;6985.79042628722;4691.7888695008805;4712.387389639325;4723.385959825201;4729.810807567727;4729.905401891943;4776.23580227162;4781.928271075867;4782.0914026334885;4784.425868895755;4796.112719146969;5560.165975103767;5570.498655121059;5573.860653483695;5578.748956296977;5582.7766889324785;6478.352164783484;6718.630475323806;6724.327567243236;6728.125343705385;6756.729730810713;1636.2800367838113;1669.182100770638;1681.0502066332483;1689.923953422099;1692.8476437120719;1084.2572837606265;1110.6945589962825;1110.9444527773578;1117.944102794857;1120.8542889424323;6238.875222495525;6246.843828904313;6284.057391391328;6295.118683384329;6297.937020629826;6791.456683465311;6828.283030281848;6836.179658440919;6840.281770414134;6864.279250678706;6113.32753397126;6250.437460628475;6261.123442718023;6261.906071408933;6291.307956124822;3686.2627474505207;3709.5177626908867;3715.996680896197;3719.088823238324;3727.161388687578;7063.081799366152;7081.92918070823;7086.468514861406;7100.183478899889;7108;6893.517453778188;6998.300169982961;7002.474814388941;7024.157101147793;7027.929720702829;7211.423086153095;7232.92767072333;7283.417326613858;7325.377342925911;7326.267373262738;6930.099087118642;6978.965105174441;6979.581225126509;7007.159140903124;7022.754203602849;6783.152105986752;6879.277675843964;6897.206821215424;6906.37842594169;6930.896036559557;7207.819804504929;7222.927770722225;7262.709491620276;7280.3083707047745;7285.162206346338;4710.26990816424;4745.169595320874;4747.952520474889;4752.477227504903;4757.785899634456;6821.147356580427;6926.480513961574;6949.096617439903;6953.4089602384365;6963.09479767627;6719.126513553402;6747.460203183636;6769.864602707819;6776.627285499148;6799.286074962058;6765.695543700447;6769.93230067693;6780.491463140185;6788.4569234462115;6792.049113124068;6476.773312934025;6580.210374754868;6616.470682345497;6633.900491492535;6646;6789.694463749044;6798.592084474947;6807.319268073153;6813;6832.93167068323;6597.6041437511985;6671.532992690465;6673.399394054559;6675.399214070562;6679.398854103154 17:34:39 INFO - PROCESS | 12788 | |5;yui.html;703.6341102626634;730.5799165479843;753.4349238071446;807.2049031703773;840.3907167303702;12721.681957951056;12878.484860605564;12896.935515322422;12919.806202906952;12933.159344642592;12662;12699.4920203192;12714.809277860817;12741.936290318536;12765.361731913414;812.4840726138915;823.217942954193;830.4062595244399;836.8451836410253;838.9244967952883;819.5369616166847;825.628467189767;827.8302947895697;829.6681327469;829.9917000829975;866.1079088538816;866.4498043742237;867.9045305016443;868.2966796894505;869.7869022089596;851.5274022917279;851.7955690634266;852.595017366752;855.5636625321068;858.7638399440142;622.0637939900466;629.6505439481086;632.1560716443554;632.9651869147195;636.3318515558645;13283.402246898913;13321.200727956257;13327.600171994856;13405.46378144873;13409.262490563015;12381.938090309492;12748.936255318664;12768.297743624096;12775.680607984874;13072.673183170402;10343.534540945675;10477.58089676412;10569.471526423726;10620.362778233331;10626.628068017659;3547.396942519778;3578.6958108560802;3593.3531964246426;3678.2091850252054;3727.403615421547;48279.758601207475;48324;48599.27101093486;48683;48725;9167.404118732395;9334.346595738232;9446.85829712555;9602.855957160647;9687.806243875082;16558.917205413894;16591.6681666366;16631.6673666526;16632.168391580613;16642.08468534218;6958.582485050812;7004.474664400089;7108.431325493948;7117.89323160153;7288;4216.768077755692;4226.195824722195;4256.34026725858;4291.828326866953;4334.371516130143;2915.3731947631363;2956.807807492506;2961.9633128404885;2966.569847372119;2973.8661760220843;542.408774435859;553.7950958145432;562.2185162623956;564.2101058518108;564.350996354196;614.4961131871822;617.675720246865;651.6578796131973;658.4403257231315;667.4726965697142;8563;9054.366194366332;9267.67563135287;9308.534573271309;9589.280803939733;534.4441780548264;579.1081734129477;697.4350775871459;713.1834050012707;713.9643017849087;3866.2460820140363;3952.9877520722503;4090.079732060322;4130.938035929464;4135.56576559463;53574.7321263399;53816;53837;54291.18563221555;57724;48226.758866206146;48299.5170048302;48963.75518122387;49442.75278623584;49647.751761240965;44937.87655308578;45420;46090.769546152726;46563.30155047677;46985.295220571716;7871.881921771293;7876.173001834725;7938.563379013978;8203.179682031749;8222.671093156207;32751.508727369586;32929.506057409635;33393.33213335768;33432.49851252282;33576;39829.60170398259;40618.18763624652;43607;44404.33393499165;44539.777301114584;10200.132988696045;10285.331453455501;10293.43386113741;10297.12474439681;10323.277370583986;10707.357558546511;10805.45972701346;10951.945240273748;11048.281861678965;11286.830697539708;10273;10343.896561034293;10419.166466682496;10445.321054131457;10607;9728.9027109728;10007.09936105754;10050.547725352522;10282.588696452058;10371.170306375321;9573.18627916635;10194.082532572103;10450.47747612601;10502.579896804347;10551.103156231498;8121.350291976746;8157.836843262983;8271.230287050492;8297.917020829715;8743.038265790885;7491.43814213947;7672.850755335128;8157.3474122071275;8291.917080829115;8620.568971551524 17:34:39 INFO - PROCESS | 12788 | __end_tp_report 17:34:39 INFO - PROCESS | 12788 | __start_cc_report 17:34:39 INFO - PROCESS | 12788 | _x_x_mozilla_cycle_collect,316 17:34:39 INFO - PROCESS | 12788 | __end_cc_report 17:34:39 INFO - PROCESS | 12788 | __startTimestamp1453253679416__endTimestamp 17:34:39 INFO - PROCESS | 12788 | 17:34:39 INFO - PROCESS | 12788 | ------- Summary: start ------- 17:34:39 INFO - PROCESS | 12788 | Number of tests: 6 17:34:39 INFO - PROCESS | 12788 | 17:34:39 INFO - PROCESS | 12788 | [#0] dojo.html Cycles:165 Average:5287.01 Median:5512.37 stddev:591.15 (10.7%) stddev-sans-first:569.76 17:34:39 INFO - PROCESS | 12788 | Values: 3196.4 3208.5 3231.2 3247.2 3279.7 5216.3 5243.2 5262.5 5282.2 5294.4 5236.1 5263.9 5293.8 5295.5 5360.4 4776.0 4804.6 4813.1 4884.0 4913.9 4549.5 4867.1 4874.5 4935.3 4939.5 4700.2 4731.7 4808.8 4829.7 4863.2 4746.2 4761.0 4771.0 4799.4 4808.7 4698.0 4729.4 4741.7 4757.2 4775.5 5121.3 5139.9 5140.3 5178.7 5181.5 5585.8 5587.9 5681.3 5690.6 5754.1 5685.6 5758.5 5764.8 5769.0 5773.7 5275.8 5365.4 5395.0 5396.4 5407.1 5827.5 5827.9 5860.2 5860.6 5901.2 5541.0 5623.8 5643.4 5651.1 5667.5 5562.4 5612.7 5678.1 5714.7 5753.2 5752.5 5753.9 5757.3 5769.5 5778.3 5729.0 5757.5 5764.7 5765.3 5766.3 4291.8 4376.3 4414.6 4448.9 4495.1 3912.6 3915.2 3921.8 3970.1 3976.2 5265.6 5279.2 5280.1 5290.5 5299.6 5638.8 5672.8 5728.3 5792.8 5878.0 5286.1 5304.3 5311.1 5313.8 5322.5 4823.3 4846.5 4847.4 4856.3 4890.3 5765.4 5782.6 5820.4 5851.7 5856.6 5635.6 5654.4 5688.5 5693.8 5728.6 5890.1 5901.4 5920.2 5934.3 5934.6 5506.1 5532.0 5658.9 5680.8 5725.5 5717.6 5729.8 5730.1 5763.2 5763.5 5611.0 5639.6 5645.2 5650.7 5657.0 5454.1 5468.0 5523.8 5543.4 5580.0 5466.1 5532.4 5538.6 5565.3 5567.0 5609.4 5634.8 5653.8 5657.7 5682.3 5409.2 5452.3 5488.1 5512.4 5536.1 17:34:39 INFO - PROCESS | 12788 | 17:34:39 INFO - PROCESS | 12788 | [#1] ext.html Cycles:180 Average:42557.15 Median:20174.93 stddev:67124.04 (332.7%) stddev-sans-first:67238.21 17:34:39 INFO - PROCESS | 12788 | Values: 543.4 560.2 584.7 598.6 598.6 36639.8 37130.6 37150.4 37260.4 37393.8 43940.8 44554.8 44597.6 44713.8 44807.6 8549.0 8819.4 8841.4 8862.2 8865.5 8572.8 8582.6 8614.0 8658.8 8678.9 8586.2 8587.7 8674.4 8722.6 8741.0 8661.5 8662.9 8679.0 8740.6 8750.9 8472.2 8600.8 8606.1 8606.4 8611.5 41100.8 41202.2 41247.0 41548.6 41671.0 2649.9 3121.2 3167.9 3178.1 3391.5 26308.5 26669.7 27074.6 27178.0 27381.6 3492.6 3710.0 3816.6 3871.3 3871.5 184406.0 185530.0 185657.0 185991.0 186058.0 53448.5 54577.2 56348.7 56662.7 62101.4 54375.2 54554.5 54866.5 54943.2 55033.7 13862.9 14002.6 14033.4 14040.3 14040.7 9841.3 9938.3 9941.9 9954.8 9970.8 20271.5 20337.0 20350.9 20483.8 20653.7 7615.0 7663.9 7772.0 7783.0 7828.6 861.5 939.4 955.7 998.1 1028.7 28767.0 29031.7 29176.4 29376.3 29743.3 997.0 1026.3 1100.4 1145.7 1176.0 15145.3 15204.8 15225.6 15275.6 15334.2 321681.0 322264.0 324518.0 325741.0 328538.0 53344.0 53424.0 53476.5 53545.5 53718.5 1274.6 1287.4 1294.6 1305.0 1305.1 28170.6 29024.0 29209.7 29214.0 29264.3 47175.0 47478.3 47484.0 47530.3 47559.8 240346.0 240959.0 241079.0 241750.0 242573.6 33105.8 33612.3 33818.8 33861.3 33964.0 38176.2 38369.6 39011.6 39878.2 42905.6 35466.5 35674.3 35681.8 35714.3 35931.8 35751.5 35848.3 35887.0 35987.5 38404.0 35150.3 35616.3 35922.3 36311.1 36368.0 30520.5 31880.5 32823.3 32839.3 33103.0 24957.8 25271.4 25308.7 25339.1 25365.2 17:34:39 INFO - PROCESS | 12788 | 17:34:39 INFO - PROCESS | 12788 | [#2] jquery.html Cycles:180 Average:26980.23 Median:46018.19 stddev:85548.38 (185.9%) stddev-sans-first:85765.02 17:34:39 INFO - PROCESS | 12788 | Values: 366.2 367.2 368.0 368.3 375.2 15831.8 16984.3 17454.3 17673.7 18485.4 10334.1 10486.0 14918.8 14970.8 15037.2 5049.3 5239.9 5652.7 5657.2 5668.8 4548.4 5528.4 5602.2 5606.0 5624.8 5093.8 5307.6 5308.9 5425.9 5510.8 5153.6 5196.3 5196.5 5221.9 5440.4 5255.3 5257.5 5262.7 5268.7 5275.7 13556.7 19842.0 20438.3 20459.3 20800.0 1854.2 1870.8 1903.5 1985.0 2006.9 8994.5 9344.2 9640.3 10008.1 11530.3 1803.7 1835.6 1835.7 1839.0 1870.5 55747.7 57453.4 57462.7 57727.4 59135.4 10242.3 10258.5 10302.6 10310.7 10341.1 13263.3 13408.7 13414.9 13421.4 13545.0 6916.8 6993.5 7022.9 7072.3 7092.1 6508.4 6523.9 6538.2 6555.1 6659.6 4420.3 4536.4 4554.6 4571.2 4581.0 1762.9 1780.8 1838.3 1843.5 1847.3 437.7 437.8 846.8 922.8 972.7 9966.8 10776.2 10860.6 10987.8 11238.7 419.4 427.6 429.3 442.5 451.7 5664.4 5677.8 5730.7 9629.2 9968.4 512133.0 514751.0 527299.0 529154.0 529911.0 73918.6 76265.6 76436.9 77033.0 77576.0 1148.7 1154.9 1166.2 1174.5 1188.9 15105.3 15290.6 15493.4 15529.4 15828.0 34872.7 34891.0 35194.5 35739.8 35775.3 45202.8 45648.5 45865.3 46171.1 46737.8 7350.2 7501.7 7547.1 7656.6 7701.2 10766.1 11235.9 11382.6 11439.3 11527.4 7392.3 8066.9 8919.7 9684.6 9809.7 9366.3 9495.2 9636.7 9966.7 10273.0 9350.4 9408.9 9418.1 9642.0 10021.2 7326.9 7363.9 7380.2 7467.3 7468.4 8539.4 9868.2 9937.9 10015.6 10120.4 17:34:39 INFO - PROCESS | 12788 | 17:34:39 INFO - PROCESS | 12788 | [#3] mootools.html Cycles:180 Average:5577.49 Median:6335.23 stddev:2843.58 (44.9%) stddev-sans-first:2834.83 17:34:39 INFO - PROCESS | 12788 | Values: 1475.3 1498.5 1666.1 1795.4 1822.1 7809.5 7910.2 7947.5 7972.9 8043.2 8080.3 8117.5 8175.9 8187.9 8200.8 2370.7 2383.9 2387.1 2389.8 2400.1 2407.3 2422.3 2429.6 2431.3 2432.8 2319.2 2371.4 2372.7 2383.6 2404.4 2359.9 2384.7 2416.1 2418.1 2419.1 2396.9 2422.6 2434.2 2434.6 2436.3 7979.6 8062.6 8068.2 8094.1 8109.2 4720.6 4827.2 4830.2 4857.9 4882.2 3182.1 3187.3 3217.5 3233.1 3273.4 1042.6 1055.1 1084.0 1113.8 1123.9 10871.2 10936.2 10989.3 11016.2 11115.8 4355.2 4360.7 4468.9 4517.3 4548.9 8635.3 8663.4 8683.4 8695.0 8698.3 4881.1 4888.4 4891.1 4905.6 4919.4 4406.3 4421.8 4430.9 4432.5 4467.2 3567.6 3574.6 3586.1 3600.9 3612.2 1100.5 1111.1 1147.3 1153.3 1162.5 1035.7 1059.2 1062.3 1173.9 1314.6 7117.4 7120.1 7150.1 7214.6 7258.9 1117.7 1140.2 1143.5 1146.9 1149.3 5774.4 5933.4 5959.7 6016.7 6018.1 9209.8 9380.4 9390.5 9572.2 9647.5 9359.0 9365.1 9408.8 9446.0 9457.7 7194.5 7246.0 7290.2 7294.1 7378.6 7390.5 7419.7 7452.4 7485.3 7526.5 8280.8 8509.7 8558.0 8618.7 8683.9 8532.2 8663.4 8693.3 8711.0 8731.0 7167.5 7292.7 7296.9 7304.3 7327.3 7588.0 7605.7 7636.0 7641.2 7672.0 6399.9 7379.1 7398.9 7429.0 7513.0 6270.5 7105.3 7149.7 7213.1 7278.4 7071.9 7088.2 7095.5 7101.4 7109.9 6585.4 6588.5 6614.2 6650.0 6656.8 6563.8 6629.1 6647.5 6746.4 6835.2 17:34:39 INFO - PROCESS | 12788 | 17:34:39 INFO - PROCESS | 12788 | [#4] prototype.html Cycles:180 Average:5599.87 Median:6257.03 stddev:1693.82 (27.1%) stddev-sans-first:1651.92 17:34:39 INFO - PROCESS | 12788 | Values: 339.9 343.7 344.4 346.7 351.7 6150.7 6252.9 6272.9 6273.2 6376.7 6069.0 6191.5 6225.0 6242.6 6247.0 4859.6 4860.5 4864.7 4865.7 4868.9 4862.7 4871.0 4875.3 4877.1 4879.5 4736.0 4792.8 4812.6 4813.5 4829.1 4764.5 4797.6 4803.7 4804.5 4819.5 4166.6 4231.1 4234.3 4249.5 4266.1 5945.1 5948.6 5969.3 5970.5 5998.7 5496.3 5639.4 5641.5 5648.6 5649.5 6661.5 6663.0 6670.8 6674.3 6689.9 4709.0 4711.0 4718.7 4719.9 4724.5 6735.8 6980.6 6983.1 6984.7 6985.8 4691.8 4712.4 4723.4 4729.8 4729.9 4776.2 4781.9 4782.1 4784.4 4796.1 5560.2 5570.5 5573.9 5578.7 5582.8 6478.4 6718.6 6724.3 6728.1 6756.7 1636.3 1669.2 1681.1 1689.9 1692.8 1084.3 1110.7 1110.9 1117.9 1120.9 6238.9 6246.8 6284.1 6295.1 6297.9 6791.5 6828.3 6836.2 6840.3 6864.3 6113.3 6250.4 6261.1 6261.9 6291.3 3686.3 3709.5 3716.0 3719.1 3727.2 7063.1 7081.9 7086.5 7100.2 7108.0 6893.5 6998.3 7002.5 7024.2 7027.9 7211.4 7232.9 7283.4 7325.4 7326.3 6930.1 6979.0 6979.6 7007.2 7022.8 6783.2 6879.3 6897.2 6906.4 6930.9 7207.8 7222.9 7262.7 7280.3 7285.2 4710.3 4745.2 4748.0 4752.5 4757.8 6821.1 6926.5 6949.1 6953.4 6963.1 6719.1 6747.5 6769.9 6776.6 6799.3 6765.7 6769.9 6780.5 6788.5 6792.0 6476.8 6580.2 6616.5 6633.9 6646.0 6789.7 6798.6 6807.3 6813.0 6832.9 6597.6 6671.5 6673.4 6675.4 6679.4 17:34:39 INFO - PROCESS | 12788 | 17:34:39 INFO - PROCESS | 12788 | [#5] yui.html Cycles:180 Average:13231.00 Median:48311.76 stddev:15456.61 (32.0%) stddev-sans-first:15471.34 17:34:39 INFO - PROCESS | 12788 | Values: 703.6 730.6 753.4 807.2 840.4 12721.7 12878.5 12896.9 12919.8 12933.2 12662.0 12699.5 12714.8 12741.9 12765.4 812.5 823.2 830.4 836.8 838.9 819.5 825.6 827.8 829.7 830.0 866.1 866.4 867.9 868.3 869.8 851.5 851.8 852.6 855.6 858.8 622.1 629.7 632.2 633.0 636.3 13283.4 13321.2 13327.6 13405.5 13409.3 12381.9 12748.9 12768.3 12775.7 13072.7 10343.5 10477.6 10569.5 10620.4 10626.6 3547.4 3578.7 3593.4 3678.2 3727.4 48279.8 48324.0 48599.3 48683.0 48725.0 9167.4 9334.3 9446.9 9602.9 9687.8 16558.9 16591.7 16631.7 16632.2 16642.1 6958.6 7004.5 7108.4 7117.9 7288.0 4216.8 4226.2 4256.3 4291.8 4334.4 2915.4 2956.8 2962.0 2966.6 2973.9 542.4 553.8 562.2 564.2 564.4 614.5 617.7 651.7 658.4 667.5 8563.0 9054.4 9267.7 9308.5 9589.3 534.4 579.1 697.4 713.2 714.0 3866.2 3953.0 4090.1 4130.9 4135.6 53574.7 53816.0 53837.0 54291.2 57724.0 48226.8 48299.5 48963.8 49442.8 49647.8 44937.9 45420.0 46090.8 46563.3 46985.3 7871.9 7876.2 7938.6 8203.2 8222.7 32751.5 32929.5 33393.3 33432.5 33576.0 39829.6 40618.2 43607.0 44404.3 44539.8 10200.1 10285.3 10293.4 10297.1 10323.3 10707.4 10805.5 10951.9 11048.3 11286.8 10273.0 10343.9 10419.2 10445.3 10607.0 9728.9 10007.1 10050.5 10282.6 10371.2 9573.2 10194.1 10450.5 10502.6 10551.1 8121.4 8157.8 8271.2 8297.9 8743.0 7491.4 7672.9 8157.3 8291.9 8620.6 17:34:39 INFO - PROCESS | 12788 | -------- Summary: end -------- 17:34:39 INFO - PROCESS | 12788 | 17:34:40 INFO - TEST-INFO | 12788: exit 0 17:34:40 INFO - TEST-OK | dromaeo_css | took 1110786ms 17:34:40 INFO - TEST-START | kraken 17:34:40 INFO - operating with platform_type : linux_ 17:34:40 INFO - Initialising browser for kraken test... 17:34:40 INFO - TEST-INFO | started process 13031 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpoRvTZE/profile http://localhost:48299/getInfo.html) 17:34:43 INFO - PROCESS | 13031 | 17:34:43 INFO - PROCESS | 13031 | (process:13100): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:34:44 INFO - PROCESS | 13031 | __metrics Screen width/height:1600/1200 17:34:44 INFO - PROCESS | 13031 | colorDepth:24 17:34:44 INFO - PROCESS | 13031 | Browser inner width/height: 1024/697 17:34:44 INFO - PROCESS | 13031 | __metrics 17:34:44 INFO - PROCESS | 13031 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:34:45 INFO - TEST-INFO | 13031: exit 0 17:34:45 INFO - Browser initialized. 17:34:45 INFO - Running cycle 1/1 for kraken test... 17:34:45 INFO - TEST-INFO | started process 13149 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpoRvTZE/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:34:46 INFO - PROCESS | 13149 | -- checkerboarding starts below -- 17:34:46 INFO - PROCESS | 13149 | RENDERTRACE 0.042764 rect red 0 0 10 10 // viewport 17:34:46 INFO - PROCESS | 13149 | RENDERTRACE 8.40486 rect red 0 0 10 10 // viewport 17:34:46 INFO - PROCESS | 13149 | RENDERTRACE 29.9152 rect brown 0 0 10 10 // page 17:34:46 INFO - PROCESS | 13149 | RENDERTRACE 29.9542 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 17:34:46 INFO - PROCESS | 13149 | Checkerboarded for 2 frames (34.4168 ms), 100 peak, 839 severity. 17:34:46 INFO - PROCESS | 13149 | 17:34:46 INFO - PROCESS | 13149 | (process:13207): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:34:57 INFO - PROCESS | 13149 | RSS: Main: 150847488 17:34:57 INFO - PROCESS | 13149 | 17:34:59 INFO - PROCESS | 13149 | Cycle 1(1): loaded http://localhost:48299/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48299/tests/kraken/driver.html?testName=audio-beat-detection) 17:35:00 INFO - PROCESS | 13149 | RSS: Main: 151142400 17:35:00 INFO - PROCESS | 13149 | 17:35:03 INFO - PROCESS | 13149 | Cycle 1(1): loaded http://localhost:48299/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48299/tests/kraken/driver.html?testName=audio-dft) 17:35:03 INFO - PROCESS | 13149 | RSS: Main: 154697728 17:35:03 INFO - PROCESS | 13149 | 17:35:06 INFO - PROCESS | 13149 | Cycle 1(1): loaded http://localhost:48299/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48299/tests/kraken/driver.html?testName=audio-fft) 17:35:07 INFO - PROCESS | 13149 | RSS: Main: 147877888 17:35:07 INFO - PROCESS | 13149 | 17:35:09 INFO - PROCESS | 13149 | Cycle 1(1): loaded http://localhost:48299/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48299/tests/kraken/driver.html?testName=audio-oscillator) 17:35:10 INFO - PROCESS | 13149 | RSS: Main: 149315584 17:35:10 INFO - PROCESS | 13149 | 17:35:12 INFO - PROCESS | 13149 | Cycle 1(1): loaded http://localhost:48299/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48299/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:35:12 INFO - PROCESS | 13149 | RSS: Main: 149274624 17:35:12 INFO - PROCESS | 13149 | 17:35:15 INFO - PROCESS | 13149 | Cycle 1(1): loaded http://localhost:48299/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48299/tests/kraken/driver.html?testName=imaging-darkroom) 17:35:16 INFO - PROCESS | 13149 | RSS: Main: 147804160 17:35:16 INFO - PROCESS | 13149 | 17:35:19 INFO - PROCESS | 13149 | Cycle 1(1): loaded http://localhost:48299/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48299/tests/kraken/driver.html?testName=imaging-desaturate) 17:35:20 INFO - PROCESS | 13149 | RSS: Main: 147922944 17:35:20 INFO - PROCESS | 13149 | 17:35:23 INFO - PROCESS | 13149 | Cycle 1(1): loaded http://localhost:48299/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48299/tests/kraken/driver.html?testName=json-parse-financial) 17:35:23 INFO - PROCESS | 13149 | RSS: Main: 148008960 17:35:23 INFO - PROCESS | 13149 | 17:35:25 INFO - PROCESS | 13149 | Cycle 1(1): loaded http://localhost:48299/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48299/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:35:25 INFO - PROCESS | 13149 | RSS: Main: 149676032 17:35:25 INFO - PROCESS | 13149 | 17:35:27 INFO - PROCESS | 13149 | Cycle 1(1): loaded http://localhost:48299/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48299/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:35:28 INFO - PROCESS | 13149 | RSS: Main: 149831680 17:35:28 INFO - PROCESS | 13149 | 17:35:30 INFO - PROCESS | 13149 | Cycle 1(1): loaded http://localhost:48299/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48299/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:35:31 INFO - PROCESS | 13149 | RSS: Main: 150335488 17:35:31 INFO - PROCESS | 13149 | 17:35:33 INFO - PROCESS | 13149 | Cycle 1(1): loaded http://localhost:48299/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48299/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:35:34 INFO - PROCESS | 13149 | RSS: Main: 148045824 17:35:34 INFO - PROCESS | 13149 | 17:35:36 INFO - PROCESS | 13149 | Cycle 1(1): loaded http://localhost:48299/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48299/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:35:37 INFO - PROCESS | 13149 | RSS: Main: 149770240 17:35:37 INFO - PROCESS | 13149 | 17:35:38 INFO - PROCESS | 13149 | Cycle 1(1): loaded http://localhost:48299/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48299/tests/kraken/driver.html?testName=ai-astar) 17:35:39 INFO - PROCESS | 13149 | RSS: Main: 149479424 17:35:39 INFO - PROCESS | 13149 | 17:35:39 INFO - PROCESS | 13149 | __start_tp_report 17:35:39 INFO - PROCESS | 13149 | _x_x_mozilla_page_load 17:35:39 INFO - PROCESS | 13149 | _x_x_mozilla_page_load_details 17:35:39 INFO - PROCESS | 13149 | |i|pagename|runs| 17:35:39 INFO - PROCESS | 13149 | |0;ai-astar;112;108;111;110;113;130;112;111;111;112 17:35:39 INFO - PROCESS | 13149 | |1;audio-beat-detection;159;129;152;165;127;175;152;130;172;125 17:35:39 INFO - PROCESS | 13149 | |2;audio-dft;162;162;162;164;162;161;162;165;165;161 17:35:39 INFO - PROCESS | 13149 | |3;audio-fft;74;76;76;73;73;73;138;73;76;73 17:35:39 INFO - PROCESS | 13149 | |4;audio-oscillator;97;98;151;96;97;96;150;98;97;141 17:35:39 INFO - PROCESS | 13149 | |5;imaging-gaussian-blur;110;109;109;110;110;110;110;111;110;110 17:35:39 INFO - PROCESS | 13149 | |6;imaging-darkroom;146;147;148;146;146;147;146;146;146;146 17:35:39 INFO - PROCESS | 13149 | |7;imaging-desaturate;96;96;97;97;97;97;97;96;96;97 17:35:39 INFO - PROCESS | 13149 | |8;json-parse-financial;60;61;60;57;59;59;60;59;67;60 17:35:39 INFO - PROCESS | 13149 | |9;json-stringify-tinderbox;74;67;67;68;69;68;68;68;69;67 17:35:39 INFO - PROCESS | 13149 | |10;stanford-crypto-aes;83;83;91;82;81;80;84;83;90;82 17:35:39 INFO - PROCESS | 13149 | |11;stanford-crypto-ccm;123;116;127;129;120;128;119;124;115;118 17:35:39 INFO - PROCESS | 13149 | |12;stanford-crypto-pbkdf2;144;152;142;145;145;135;148;147;157;142 17:35:39 INFO - PROCESS | 13149 | |13;stanford-crypto-sha256-iterative;69;67;70;66;70;68;68;65;66;67 17:35:39 INFO - PROCESS | 13149 | __end_tp_report 17:35:39 INFO - PROCESS | 13149 | __start_cc_report 17:35:39 INFO - PROCESS | 13149 | _x_x_mozilla_cycle_collect,729 17:35:39 INFO - PROCESS | 13149 | __end_cc_report 17:35:39 INFO - PROCESS | 13149 | __startTimestamp1453253739107__endTimestamp 17:35:39 INFO - PROCESS | 13149 | 17:35:39 INFO - PROCESS | 13149 | ------- Summary: start ------- 17:35:39 INFO - PROCESS | 13149 | Number of tests: 14 17:35:39 INFO - PROCESS | 13149 | 17:35:39 INFO - PROCESS | 13149 | [#0] ai-astar Cycles:10 Average:113.00 Median:112.00 stddev:6.13 (5.5%) stddev-sans-first:6.49 17:35:39 INFO - PROCESS | 13149 | Values: 112.0 108.0 111.0 110.0 113.0 130.0 112.0 111.0 111.0 112.0 17:35:39 INFO - PROCESS | 13149 | 17:35:39 INFO - PROCESS | 13149 | [#1] audio-beat-detection Cycles:10 Average:148.60 Median:155.50 stddev:19.43 (12.5%) stddev-sans-first:20.24 17:35:39 INFO - PROCESS | 13149 | Values: 159.0 129.0 152.0 165.0 127.0 175.0 152.0 130.0 172.0 125.0 17:35:39 INFO - PROCESS | 13149 | 17:35:39 INFO - PROCESS | 13149 | [#2] audio-dft Cycles:10 Average:162.60 Median:162.00 stddev:1.51 (0.9%) stddev-sans-first:1.58 17:35:39 INFO - PROCESS | 13149 | Values: 162.0 162.0 162.0 164.0 162.0 161.0 162.0 165.0 165.0 161.0 17:35:39 INFO - PROCESS | 13149 | 17:35:39 INFO - PROCESS | 13149 | [#3] audio-fft Cycles:10 Average:80.50 Median:73.50 stddev:20.25 (27.6%) stddev-sans-first:21.34 17:35:39 INFO - PROCESS | 13149 | Values: 74.0 76.0 76.0 73.0 73.0 73.0 138.0 73.0 76.0 73.0 17:35:39 INFO - PROCESS | 13149 | 17:35:39 INFO - PROCESS | 13149 | [#4] audio-oscillator Cycles:10 Average:112.10 Median:97.00 stddev:24.46 (25.2%) stddev-sans-first:25.33 17:35:39 INFO - PROCESS | 13149 | Values: 97.0 98.0 151.0 96.0 97.0 96.0 150.0 98.0 97.0 141.0 17:35:39 INFO - PROCESS | 13149 | 17:35:39 INFO - PROCESS | 13149 | [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 17:35:39 INFO - PROCESS | 13149 | Values: 110.0 109.0 109.0 110.0 110.0 110.0 110.0 111.0 110.0 110.0 17:35:39 INFO - PROCESS | 13149 | 17:35:39 INFO - PROCESS | 13149 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 17:35:39 INFO - PROCESS | 13149 | Values: 146.0 147.0 148.0 146.0 146.0 147.0 146.0 146.0 146.0 146.0 17:35:39 INFO - PROCESS | 13149 | 17:35:39 INFO - PROCESS | 13149 | [#7] imaging-desaturate Cycles:10 Average:96.60 Median:97.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 17:35:39 INFO - PROCESS | 13149 | Values: 96.0 96.0 97.0 97.0 97.0 97.0 97.0 96.0 96.0 97.0 17:35:39 INFO - PROCESS | 13149 | 17:35:39 INFO - PROCESS | 13149 | [#8] json-parse-financial Cycles:10 Average:60.20 Median:60.00 stddev:2.62 (4.4%) stddev-sans-first:2.77 17:35:39 INFO - PROCESS | 13149 | Values: 60.0 61.0 60.0 57.0 59.0 59.0 60.0 59.0 67.0 60.0 17:35:39 INFO - PROCESS | 13149 | 17:35:39 INFO - PROCESS | 13149 | [#9] json-stringify-tinderbox Cycles:10 Average:68.50 Median:68.00 stddev:2.07 (3.0%) stddev-sans-first:0.78 17:35:39 INFO - PROCESS | 13149 | Values: 74.0 67.0 67.0 68.0 69.0 68.0 68.0 68.0 69.0 67.0 17:35:39 INFO - PROCESS | 13149 | 17:35:39 INFO - PROCESS | 13149 | [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:83.00 stddev:3.67 (4.4%) stddev-sans-first:3.87 17:35:39 INFO - PROCESS | 13149 | Values: 83.0 83.0 91.0 82.0 81.0 80.0 84.0 83.0 90.0 82.0 17:35:39 INFO - PROCESS | 13149 | 17:35:39 INFO - PROCESS | 13149 | [#11] stanford-crypto-ccm Cycles:10 Average:121.90 Median:123.50 stddev:5.04 (4.1%) stddev-sans-first:5.33 17:35:39 INFO - PROCESS | 13149 | Values: 123.0 116.0 127.0 129.0 120.0 128.0 119.0 124.0 115.0 118.0 17:35:39 INFO - PROCESS | 13149 | 17:35:39 INFO - PROCESS | 13149 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.70 Median:146.00 stddev:5.96 (4.1%) stddev-sans-first:6.29 17:35:39 INFO - PROCESS | 13149 | Values: 144.0 152.0 142.0 145.0 145.0 135.0 148.0 147.0 157.0 142.0 17:35:39 INFO - PROCESS | 13149 | 17:35:39 INFO - PROCESS | 13149 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:68.00 stddev:1.71 (2.5%) stddev-sans-first:1.74 17:35:39 INFO - PROCESS | 13149 | Values: 69.0 67.0 70.0 66.0 70.0 68.0 68.0 65.0 66.0 67.0 17:35:39 INFO - PROCESS | 13149 | -------- Summary: end -------- 17:35:39 INFO - PROCESS | 13149 | 17:35:40 INFO - TEST-INFO | 13149: exit 0 17:35:40 INFO - TEST-OK | kraken | took 60009ms 17:35:40 INFO - TEST-START | v8_7 17:35:40 INFO - operating with platform_type : linux_ 17:35:40 INFO - Initialising browser for v8_7 test... 17:35:40 INFO - TEST-INFO | started process 13435 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpFSkNuR/profile http://localhost:48299/getInfo.html) 17:35:43 INFO - PROCESS | 13435 | 17:35:43 INFO - PROCESS | 13435 | (process:13506): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:35:44 INFO - PROCESS | 13435 | __metrics Screen width/height:1600/1200 17:35:44 INFO - PROCESS | 13435 | colorDepth:24 17:35:44 INFO - PROCESS | 13435 | Browser inner width/height: 1024/697 17:35:44 INFO - PROCESS | 13435 | __metrics 17:35:44 INFO - PROCESS | 13435 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:35:45 INFO - TEST-INFO | 13435: exit 0 17:35:45 INFO - Browser initialized. 17:35:45 INFO - Running cycle 1/1 for v8_7 test... 17:35:45 INFO - TEST-INFO | started process 13555 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpFSkNuR/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:35:46 INFO - PROCESS | 13555 | -- checkerboarding starts below -- 17:35:46 INFO - PROCESS | 13555 | RENDERTRACE 0.055965 rect red 0 0 10 10 // viewport 17:35:46 INFO - PROCESS | 13555 | RENDERTRACE 20.3068 rect brown 0 0 10 10 // page 17:35:46 INFO - PROCESS | 13555 | RENDERTRACE 20.3242 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 17:35:46 INFO - PROCESS | 13555 | Checkerboarded for 1 frames (29.0639 ms), 100 peak, 1 severity. 17:35:47 INFO - PROCESS | 13555 | 17:35:47 INFO - PROCESS | 13555 | (process:13614): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:35:57 INFO - PROCESS | 13555 | RSS: Main: 149016576 17:35:57 INFO - PROCESS | 13555 | 17:36:20 INFO - PROCESS | 13555 | Cycle 1(1): loaded http://localhost:48299/tests/v8_7/run.html (next: http://localhost:48299/tests/v8_7/run.html) 17:36:20 INFO - PROCESS | 13555 | RSS: Main: 146370560 17:36:20 INFO - PROCESS | 13555 | 17:36:20 INFO - PROCESS | 13555 | __start_tp_report 17:36:20 INFO - PROCESS | 13555 | _x_x_mozilla_page_load 17:36:20 INFO - PROCESS | 13555 | _x_x_mozilla_page_load_details 17:36:20 INFO - PROCESS | 13555 | |i|pagename|runs| 17:36:20 INFO - PROCESS | 13555 | |0;Richards;169.14749661705008 17:36:20 INFO - PROCESS | 13555 | |1;DeltaBlue;187.2308556450103 17:36:20 INFO - PROCESS | 13555 | |2;Encrypt;279.56388034665923 17:36:20 INFO - PROCESS | 13555 | |3;Decrypt;5208.333333333333 17:36:20 INFO - PROCESS | 13555 | |4;RayTrace;1074.1138560687432 17:36:20 INFO - PROCESS | 13555 | |5;Earley;704.7216349541931 17:36:20 INFO - PROCESS | 13555 | |6;Boyer;12345.67901234568 17:36:20 INFO - PROCESS | 13555 | |7;RegExp;41320 17:36:20 INFO - PROCESS | 13555 | |8;Splay;590.318772136954 17:36:20 INFO - PROCESS | 13555 | |9;NavierStokes;4817.307692307692 17:36:20 INFO - PROCESS | 13555 | __end_tp_report 17:36:20 INFO - PROCESS | 13555 | __startTimestamp1453253780280__endTimestamp 17:36:20 INFO - PROCESS | 13555 | 17:36:20 INFO - PROCESS | 13555 | ------- Summary: start ------- 17:36:20 INFO - PROCESS | 13555 | Number of tests: 10 17:36:20 INFO - PROCESS | 13555 | 17:36:20 INFO - PROCESS | 13555 | [#0] Richards Cycles:1 Average:169.15 Median:169.15 stddev:0.00 (0.0%) 17:36:20 INFO - PROCESS | 13555 | Values: 169.1 17:36:20 INFO - PROCESS | 13555 | 17:36:20 INFO - PROCESS | 13555 | [#1] DeltaBlue Cycles:1 Average:187.23 Median:187.23 stddev:0.00 (0.0%) 17:36:20 INFO - PROCESS | 13555 | Values: 187.2 17:36:20 INFO - PROCESS | 13555 | 17:36:20 INFO - PROCESS | 13555 | [#2] Encrypt Cycles:1 Average:279.56 Median:279.56 stddev:0.00 (0.0%) 17:36:20 INFO - PROCESS | 13555 | Values: 279.6 17:36:20 INFO - PROCESS | 13555 | 17:36:20 INFO - PROCESS | 13555 | [#3] Decrypt Cycles:1 Average:5208.33 Median:5208.33 stddev:0.00 (0.0%) 17:36:20 INFO - PROCESS | 13555 | Values: 5208.3 17:36:20 INFO - PROCESS | 13555 | 17:36:20 INFO - PROCESS | 13555 | [#4] RayTrace Cycles:1 Average:1074.11 Median:1074.11 stddev:0.00 (0.0%) 17:36:20 INFO - PROCESS | 13555 | Values: 1074.1 17:36:20 INFO - PROCESS | 13555 | 17:36:20 INFO - PROCESS | 13555 | [#5] Earley Cycles:1 Average:704.72 Median:704.72 stddev:0.00 (0.0%) 17:36:20 INFO - PROCESS | 13555 | Values: 704.7 17:36:20 INFO - PROCESS | 13555 | 17:36:20 INFO - PROCESS | 13555 | [#6] Boyer Cycles:1 Average:12345.68 Median:12345.68 stddev:0.00 (0.0%) 17:36:20 INFO - PROCESS | 13555 | Values: 12345.7 17:36:20 INFO - PROCESS | 13555 | 17:36:20 INFO - PROCESS | 13555 | [#7] RegExp Cycles:1 Average:41320.00 Median:41320.00 stddev:0.00 (0.0%) 17:36:20 INFO - PROCESS | 13555 | Values: 41320.0 17:36:20 INFO - PROCESS | 13555 | 17:36:20 INFO - PROCESS | 13555 | [#8] Splay Cycles:1 Average:590.32 Median:590.32 stddev:0.00 (0.0%) 17:36:20 INFO - PROCESS | 13555 | Values: 590.3 17:36:20 INFO - PROCESS | 13555 | 17:36:20 INFO - PROCESS | 13555 | [#9] NavierStokes Cycles:1 Average:4817.31 Median:4817.31 stddev:0.00 (0.0%) 17:36:20 INFO - PROCESS | 13555 | Values: 4817.3 17:36:20 INFO - PROCESS | 13555 | -------- Summary: end -------- 17:36:20 INFO - PROCESS | 13555 | 17:36:21 INFO - TEST-INFO | 13555: exit 0 17:36:21 INFO - TEST-OK | v8_7 | took 40990ms 17:36:21 INFO - SUITE-END | took 1211s 17:36:21 INFO - Completed test suite (00:20:11) 17:36:21 INFO - Working with test: dromaeo_css 17:36:21 INFO - Generating results file: dromaeo_css 17:36:21 INFO - Working with test: kraken 17:36:21 INFO - Generating results file: kraken 17:36:21 INFO - javascript benchmark 17:36:21 INFO - Working with test: v8_7 17:36:21 INFO - Generating results file: v8_7 17:36:21 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:36:21 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 17:36:21 INFO - process_Request line: dromaeo_css 6848.34 graph.html#tests=[[72,64,43]] 17:36:21 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:36:21 INFO - process_Request line: kraken 1517.50 graph.html#tests=[[232,64,43]] 17:36:21 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:36:21 INFO - process_Request line: v8_7 20401.66 graph.html#tests=[[230,64,43]] 17:36:21 INFO - RETURN: dromaeo_css: 6848.34 17:36:21 INFO - RETURN: kraken: 1517.50 17:36:21 INFO - RETURN: v8_7: 20401.66 17:36:21 INFO - javascript benchmark 17:36:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3196.3607278544296, 3208.4545627243365, 3231.2406584452665, 3247.2206670399105, 3279.7376209903196, 5216.26972223888, 5243.16109422493, 5262.473752624735, 5282.2076688496745, 5294.444083371249, 5236.057509648262, 5263.894722105565, 5293.814716484924, 5295.523402893738, 5360.356757189143, 4776.044791041788, 4804.615630749532, 4813.061453016663, 4883.9511604883855, 4913.9189378336705, 4549.454065512126, 4867.1482490564185, 4874.53691899269, 4935.259711043354, 4939.506049395068, 4700.224462963607, 4731.69243999139, 4808.759562021885, 4829.686070405448, 4863.17326054568, 4746.1931471649905, 4761.0, 4771.045790841846, 4799.3760811094335, 4808.711477311337, 4697.976510117462, 4729.432468103815, 4741.739204343759, 4757.215059515176, 4775.498572649891, 5121.28302037715, 5139.9229011564485, 5140.306058682105, 5178.715170665612, 5181.481851814826, 5585.776568937237, 5587.916181257285, 5681.261436013292, 5690.573207009449, 5754.136879468071, 5685.602007859451, 5758.510526605243, 5764.769409223626, 5769.0, 5773.711314434261, 5275.788968441258, 5365.409804921455, 5394.973025134849, 5396.352437707461, 5407.107827208506, 5827.533797296206, 5827.883442331215, 5860.208871802252, 5860.560457965669, 5901.232839730807, 5541.0, 5623.831285061455, 5643.40744221859, 5651.095824668116, 5667.489925906688, 5562.443755624405, 5612.719364031864, 5678.119891416837, 5714.685692286964, 5753.194552762617, 5752.511036561856, 5753.884922301614, 5757.309122905278, 5769.451902069297, 5778.27771528559, 5728.971355143198, 5757.539396848242, 5764.654120752768, 5765.250517432707, 5766.336871259775, 4291.806868690854, 4376.277914144194, 4414.646828253732, 4448.888777780581, 4495.145922274757, 3912.550056743454, 3915.1778126593736, 3921.8431262749173, 3970.1265721541213, 3976.165005348851, 5265.631405801557, 5279.234510995961, 5280.102382594968, 5290.523852853262, 5299.6025298102795, 5638.774449021993, 5672.773089076473, 5728.255326807488, 5792.79725209624, 5878.0, 5286.101362768339, 5304.310439642822, 5311.070562651521, 5313.840584782385, 5322.467753224724, 4823.300621409876, 4846.466888642247, 4847.418309802846, 4856.271559266138, 4890.339804126468, 5765.423457654201, 5782.624129431573, 5820.447057529528, 5851.736671849691, 5856.619319744203, 5635.633683810539, 5654.40628733977, 5688.459596338341, 5693.772249109989, 5728.570357223308, 5890.057590785454, 5901.409859014064, 5920.230370052038, 5934.3175534814045, 5934.554908381975, 5506.1190209566275, 5532.004239236976, 5658.9151162733415, 5680.801171959127, 5725.513331366714, 5717.628354156966, 5729.799457018984, 5730.08318669011, 5763.193152958505, 5763.510101641407, 5611.046122159324, 5639.577031722555, 5645.181448689835, 5650.689212093374, 5656.971715141398, 5454.10007348783, 5467.988422141916, 5523.7790488380015, 5543.3902270751, 5579.972100139474, 5466.125419932791, 5532.446755324436, 5538.6399884007415, 5565.332160140809, 5566.97216513931, 5609.4390560943575, 5634.802781902614, 5653.830385088454, 5657.745401456862, 5682.261306030189, 5409.215663728816, 5452.291202143696, 5488.149336852634, 5512.3660779010925, 5536.141898005815], "unit": "score", "name": "dojo.html", "value": 5248.9051706084165}, {"lowerIsBetter": false, "replicates": [543.4402565357683, 560.179337270898, 584.7134903897091, 598.6378241164095, 598.6467983889505, 36639.81680091599, 37130.62869371302, 37150.442743358806, 37260.44109338359, 37393.81303093488, 43940.78029609848, 44554.77722611382, 44597.55402445982, 44713.776431117796, 44807.551924480824, 8549.0, 8819.426737262089, 8841.425307355034, 8862.24670902974, 8865.468071915673, 8572.785680357978, 8582.570871456433, 8614.0, 8658.826823463527, 8678.86981695275, 8586.22723954844, 8587.699430519933, 8674.436161649504, 8722.563871806417, 8741.038485766561, 8661.523616201106, 8662.87005694915, 8678.956605216934, 8740.562971851414, 8750.86873696892, 8472.19514146155, 8600.784980375478, 8606.053334133303, 8606.35452341077, 8611.48331100136, 41100.79449602763, 41202.175956481005, 41247.0, 41548.584514155074, 41671.0, 2649.894004239828, 3121.2352973521406, 3167.857446414917, 3178.126015345775, 3391.4573668212965, 26308.473830523475, 26669.73330266711, 27074.593881091798, 27178.0, 27381.589276160874, 3492.6158122606494, 3710.035390798385, 3816.618338166189, 3871.322518559269, 3871.535415750128, 184406.0, 185530.0, 185657.0, 185991.0, 186058.0, 53448.465515345124, 54577.181342279895, 56348.71825640846, 56662.71668641713, 62101.37898621046, 54375.18437223445, 54554.45445545573, 54866.451335486134, 54943.17585236225, 55033.724831375584, 13862.93068534651, 14002.649933751738, 14033.438662453591, 14040.297985100704, 14040.71918561623, 9841.261905357127, 9938.254630902567, 9941.850872236922, 9954.751131221632, 9970.750731231778, 20271.4932126698, 20337.0, 20350.898245508677, 20483.795162048187, 20653.690194647093, 7615.0, 7663.885041724378, 7771.961140194263, 7783.0, 7828.569428681477, 861.5261606116611, 939.3706216834737, 955.6655170690342, 998.1266391907081, 1028.7325295423095, 28767.0, 29031.70968290332, 29176.416471670447, 29376.26559336034, 29743.25641858971, 997.0179373317277, 1026.3482688492861, 1100.3837850803575, 1145.7422080031927, 1176.04152615618, 15145.311916324243, 15204.771928421083, 15225.6193595161, 15275.618109547127, 15334.156621385708, 321681.0, 322264.0, 324518.0, 325741.0, 328538.0, 53344.0, 53424.0, 53476.465235347925, 53545.46454535483, 53718.46281537135, 1274.6494713953552, 1287.4270949427603, 1294.643972907458, 1304.9739005219842, 1305.1386085183733, 28170.577441337988, 29024.0, 29209.707902920698, 29214.0, 29264.26839329034, 47175.0, 47478.287825683336, 47484.0, 47530.28704569365, 47559.76842547248, 240346.0, 240959.0, 241079.0, 241750.0, 242573.57426426216, 33105.83447082749, 33612.327753445286, 33818.830905845316, 33861.32277354488, 33964.0, 38176.236475270896, 38369.61630383661, 39011.6098839008, 39878.2024359517, 42905.57094429016, 35466.46800297946, 35674.28651426905, 35681.82159089188, 35714.28571428505, 35931.820340899176, 35751.46372804358, 35848.283034338645, 35887.0, 35987.46018809667, 38404.0, 35150.29699405946, 35616.287674245854, 35922.28155436929, 36311.09222269359, 36368.0, 30520.542191866694, 31880.521792172673, 32823.34353312968, 32839.34321313513, 33103.0, 24957.75042249627, 25271.368215794017, 25308.746912530638, 25339.128013366484, 25365.239042828744], "unit": "score", "name": "ext.html", "value": 17929.14388977264}, {"lowerIsBetter": false, "replicates": [366.23639711202145, 367.1885133854183, 367.97240206984463, 368.29839156407047, 375.1802311948391, 15831.762523562142, 16984.32062717493, 17454.301827926884, 17673.7348939766, 18485.44543663689, 10334.121599664037, 10486.011486726284, 14918.776218356734, 14970.775438368433, 15037.248137593131, 5049.318342023835, 5239.895202095956, 5652.745626446799, 5657.23627310314, 5668.829935101953, 4548.363229147905, 5528.419515950827, 5602.1596760485845, 5606.046972014747, 5624.803131890385, 5093.847184584469, 5307.601929855257, 5308.946910530904, 5425.891482170354, 5510.779568817243, 5153.613478989091, 5196.324477817879, 5196.480351964811, 5221.947780522203, 5440.374356948962, 5255.343082114736, 5257.5005374489365, 5262.657927234755, 5268.710220937847, 5275.683458992473, 13556.728865422636, 19842.0, 20438.284660036978, 20459.2839250627, 20800.0, 1854.2387220383714, 1870.8129187081183, 1903.5146037760283, 1984.9932126359229, 2006.8695534790338, 8994.505302208376, 9344.15902568772, 9640.276979226515, 10008.149307308888, 11530.308181509135, 1803.7474753534516, 1835.6420498002894, 1835.715464103053, 1838.980237898243, 1870.5043163561668, 55747.72126139384, 57453.425465745226, 57462.71268643672, 57727.42272577262, 59135.40864591342, 10242.334248273839, 10258.487075646188, 10302.639407620698, 10310.742231444274, 10341.069303762548, 13263.336833158304, 13408.664783380493, 13414.932925335506, 13421.39603717835, 13545.0, 6916.792496225121, 6993.545419547815, 7022.92977070233, 7072.292770722886, 7092.113485814273, 6508.446782023581, 6523.902141467882, 6538.1500404947055, 6555.115059466911, 6659.567128136656, 4420.336949457543, 4536.4102666653125, 4554.63562914966, 4571.222892108283, 4580.954190458119, 1762.9382971595933, 1780.8130146334706, 1838.2737771840887, 1843.511469460594, 1847.3466247708227, 437.7154849347949, 437.75485727992424, 846.7713717296418, 922.820050090226, 972.6984634763246, 9966.750831229132, 10776.19178561611, 10860.61987830438, 10987.835182472269, 11238.66284011481, 419.42329297216327, 427.57029185668205, 429.2852400752774, 442.5353378952087, 451.6793076915361, 5664.405237450091, 5677.829665110054, 5730.7421166047625, 9629.229661627052, 9968.35205711641, 512133.0, 514751.0, 527299.0, 529154.0, 529911.0, 73918.63040684762, 76265.61867190628, 76436.85344719833, 77033.0, 77576.0, 1148.655403378983, 1154.9364784936909, 1166.1836714300193, 1174.5477990973366, 1188.8632807227107, 15105.32026058808, 15290.617734556725, 15493.380264789283, 15529.378824847332, 15828.0, 34872.65127348796, 34890.99999999898, 35194.47208291826, 35739.82130089333, 35775.28449431049, 45202.77398612986, 45648.54351456443, 45865.312020319056, 46171.07657846757, 46737.76631116823, 7350.19147893742, 7501.699932002659, 7547.132079810892, 7656.578888161204, 7701.191374905554, 10766.084882785051, 11235.887641123483, 11382.601608943978, 11439.256448330832, 11527.365994870363, 7392.309141944695, 8066.878996814935, 8919.687810926587, 9684.56419461112, 9809.705708828747, 9366.250699943852, 9495.24038076966, 9636.662716804878, 9966.700998970042, 10273.0, 9350.392224505385, 9408.905910941077, 9418.058194180801, 9641.951790241004, 10021.198304135798, 7326.890096648661, 7363.889541656772, 7380.225076366904, 7467.327940485382, 7468.4398670101045, 8539.359548034046, 9868.210543156387, 9937.900620993987, 10015.649452269136, 10120.392776433437], "unit": "score", "name": "jquery.html", "value": 7753.656601515839}, {"lowerIsBetter": false, "replicates": [1475.2844870237936, 1498.4980031689383, 1666.1003058348492, 1795.4254638515663, 1822.1071674879304, 7809.492382995101, 7910.208979102102, 7947.523148611087, 7972.880406793895, 8043.235892590209, 8080.272775450208, 8117.512949223051, 8175.91824081759, 8187.877181842277, 8200.835983280345, 2370.715514138306, 2383.9404014899637, 2387.092904696213, 2389.761023897605, 2400.147947478646, 2407.277816655005, 2422.2854257993845, 2429.5748244057218, 2431.258466167818, 2432.7567243275707, 2319.1535089692225, 2371.4308565944134, 2372.6678265042906, 2383.618621020637, 2404.362843846382, 2359.9174028908906, 2384.725756537994, 2416.1060407649106, 2418.056957786465, 2419.129113519132, 2396.940076498084, 2422.551827911824, 2434.184548176363, 2434.6469761884605, 2436.317831007321, 7979.56112413817, 8062.637181326854, 8068.193180681944, 8094.109647938722, 8109.229623185788, 4720.622350212009, 4827.155247831651, 4830.178869592178, 4857.878553036167, 4882.218844984821, 3182.0931034655246, 3187.3147273336112, 3217.469117595594, 3233.143217047484, 3273.427150248721, 1042.6142327338932, 1055.134789472625, 1083.9891601083966, 1113.8050841102774, 1123.9044681202108, 10871.184661150446, 10936.179786515964, 10989.285696429706, 11016.17378696593, 11115.777684446266, 4355.1725172217175, 4360.716553424018, 4468.932966005513, 4517.299818528133, 4548.931766023512, 8635.30917526609, 8663.35024873137, 8683.435576687496, 8694.956525217334, 8698.260647844878, 4881.096997055556, 4888.364512613338, 4891.144049791273, 4905.632077594195, 4919.409670839522, 4406.272964960745, 4421.756803375781, 4430.889227769331, 4432.512423633398, 4467.195904737114, 3567.5897271813556, 3574.588922273972, 3586.1393265616066, 3600.9459858101627, 3612.2414292998237, 1100.5157730598512, 1111.105560024172, 1147.2886810177743, 1153.348358177627, 1162.505934977648, 1035.7151783259665, 1059.21618002679, 1062.293574772783, 1173.8884805943421, 1314.5990472905855, 7117.395021423134, 7120.074390329328, 7150.10623672041, 7214.603196824225, 7258.891116633255, 1117.6982214801958, 1140.1676775953435, 1143.5482984221187, 1146.850909381775, 1149.3104137517423, 5774.393688662714, 5933.436323549256, 5959.702014899324, 6016.669083200379, 6018.067199583984, 9209.769755756026, 9380.437173769596, 9390.5304734763, 9572.234221262283, 9647.517624118766, 9358.953205233931, 9365.11031452011, 9408.764780880532, 9446.0, 9457.668981585612, 7194.496385253086, 7246.021787058785, 7290.161631412349, 7294.051773269441, 7378.557286562824, 7390.482666213314, 7419.703211871465, 7452.441066919894, 7485.251474852689, 7526.5107767994905, 8280.83438331218, 8509.74470765878, 8557.957210213908, 8618.741437756877, 8683.869741954002, 8532.23209911111, 8663.39356245082, 8693.30453563726, 8710.99823520278, 8731.0, 7167.498275120692, 7292.744753933587, 7296.854062918605, 7304.342609165201, 7327.303906129123, 7587.962060189884, 7605.695772169051, 7635.961820190863, 7641.159472457914, 7672.0, 6399.936000639934, 7379.114506259283, 7398.852022959618, 7428.962855185906, 7513.0, 6270.529710271657, 7105.32499412555, 7149.714011439484, 7213.062301900719, 7278.381337586365, 7071.929280707127, 7088.184858741311, 7095.46783991213, 7101.360877520841, 7109.928900710926, 6585.407313341822, 6588.505862060269, 6614.239362473377, 6649.966750166218, 6656.83357916056, 6563.803085907431, 6629.071929929717, 6647.534672572873, 6746.392824645805, 6835.21395039557], "unit": "score", "name": "mootools.html", "value": 4604.415392012717}, {"lowerIsBetter": false, "replicates": [339.9218179818642, 343.71643394199793, 344.42824910648346, 346.6810534308436, 351.6852417086707, 6150.708351246244, 6252.937470625292, 6272.874542509147, 6273.215848018997, 6376.744930202786, 6069.0, 6191.535634827384, 6225.0, 6242.625442473443, 6247.0317100849325, 4859.562639362457, 4860.513948605147, 4864.708117512961, 4865.732384718848, 4868.9269660955115, 4862.6839255448285, 4870.975645121769, 4875.341828853113, 4877.097736918664, 4879.536444037829, 4736.005438857844, 4792.83225087122, 4812.590929770956, 4813.518648135194, 4829.106615276168, 4764.499727528594, 4797.568218860302, 4803.663743537953, 4804.519548045202, 4819.49395313494, 4166.562510936338, 4231.1114665920195, 4234.280172370704, 4249.46881639795, 4266.1467706458525, 5945.078512830518, 5948.553858460589, 5969.283685957713, 5970.492508136814, 5998.730057147395, 5496.340439147288, 5639.351474580435, 5641.5204707599905, 5648.604597678164, 5649.548036157139, 6661.500387470959, 6662.966685166592, 6670.83322916931, 6674.299198584175, 6689.8662026759675, 4709.034647897173, 4710.9764451177525, 4718.716876987358, 4719.882002949919, 4724.5039270876405, 6735.797926062177, 6980.616066116361, 6983.12710911131, 6984.720611175547, 6985.79042628722, 4691.7888695008805, 4712.387389639325, 4723.385959825201, 4729.810807567727, 4729.905401891943, 4776.23580227162, 4781.928271075867, 4782.0914026334885, 4784.425868895755, 4796.112719146969, 5560.165975103767, 5570.498655121059, 5573.860653483695, 5578.748956296977, 5582.7766889324785, 6478.352164783484, 6718.630475323806, 6724.327567243236, 6728.125343705385, 6756.729730810713, 1636.2800367838113, 1669.182100770638, 1681.0502066332483, 1689.923953422099, 1692.8476437120719, 1084.2572837606265, 1110.6945589962825, 1110.9444527773578, 1117.944102794857, 1120.8542889424323, 6238.875222495525, 6246.843828904313, 6284.057391391328, 6295.118683384329, 6297.937020629826, 6791.456683465311, 6828.283030281848, 6836.179658440919, 6840.281770414134, 6864.279250678706, 6113.32753397126, 6250.437460628475, 6261.123442718023, 6261.906071408933, 6291.307956124822, 3686.2627474505207, 3709.5177626908867, 3715.996680896197, 3719.088823238324, 3727.161388687578, 7063.081799366152, 7081.92918070823, 7086.468514861406, 7100.183478899889, 7108.0, 6893.517453778188, 6998.300169982961, 7002.474814388941, 7024.157101147793, 7027.929720702829, 7211.423086153095, 7232.92767072333, 7283.417326613858, 7325.377342925911, 7326.267373262738, 6930.099087118642, 6978.965105174441, 6979.581225126509, 7007.159140903124, 7022.754203602849, 6783.152105986752, 6879.277675843964, 6897.206821215424, 6906.37842594169, 6930.896036559557, 7207.819804504929, 7222.927770722225, 7262.709491620276, 7280.3083707047745, 7285.162206346338, 4710.26990816424, 4745.169595320874, 4747.952520474889, 4752.477227504903, 4757.785899634456, 6821.147356580427, 6926.480513961574, 6949.096617439903, 6953.4089602384365, 6963.09479767627, 6719.126513553402, 6747.460203183636, 6769.864602707819, 6776.627285499148, 6799.286074962058, 6765.695543700447, 6769.93230067693, 6780.491463140185, 6788.4569234462115, 6792.049113124068, 6476.773312934025, 6580.210374754868, 6616.470682345497, 6633.900491492535, 6646.0, 6789.694463749044, 6798.592084474947, 6807.319268073153, 6813.0, 6832.93167068323, 6597.6041437511985, 6671.532992690465, 6673.399394054559, 6675.399214070562, 6679.398854103154], "unit": "score", "name": "prototype.html", "value": 5043.037830012419}, {"lowerIsBetter": false, "replicates": [703.6341102626634, 730.5799165479843, 753.4349238071446, 807.2049031703773, 840.3907167303702, 12721.681957951056, 12878.484860605564, 12896.935515322422, 12919.806202906952, 12933.159344642592, 12662.0, 12699.4920203192, 12714.809277860817, 12741.936290318536, 12765.361731913414, 812.4840726138915, 823.217942954193, 830.4062595244399, 836.8451836410253, 838.9244967952883, 819.5369616166847, 825.628467189767, 827.8302947895697, 829.6681327469, 829.9917000829975, 866.1079088538816, 866.4498043742237, 867.9045305016443, 868.2966796894505, 869.7869022089596, 851.5274022917279, 851.7955690634266, 852.595017366752, 855.5636625321068, 858.7638399440142, 622.0637939900466, 629.6505439481086, 632.1560716443554, 632.9651869147195, 636.3318515558645, 13283.402246898913, 13321.200727956257, 13327.600171994856, 13405.46378144873, 13409.262490563015, 12381.938090309492, 12748.936255318664, 12768.297743624096, 12775.680607984874, 13072.673183170402, 10343.534540945675, 10477.58089676412, 10569.471526423726, 10620.362778233331, 10626.628068017659, 3547.396942519778, 3578.6958108560802, 3593.3531964246426, 3678.2091850252054, 3727.403615421547, 48279.758601207475, 48324.0, 48599.27101093486, 48683.0, 48725.0, 9167.404118732395, 9334.346595738232, 9446.85829712555, 9602.855957160647, 9687.806243875082, 16558.917205413894, 16591.6681666366, 16631.6673666526, 16632.168391580613, 16642.08468534218, 6958.582485050812, 7004.474664400089, 7108.431325493948, 7117.89323160153, 7288.0, 4216.768077755692, 4226.195824722195, 4256.34026725858, 4291.828326866953, 4334.371516130143, 2915.3731947631363, 2956.807807492506, 2961.9633128404885, 2966.569847372119, 2973.8661760220843, 542.408774435859, 553.7950958145432, 562.2185162623956, 564.2101058518108, 564.350996354196, 614.4961131871822, 617.675720246865, 651.6578796131973, 658.4403257231315, 667.4726965697142, 8563.0, 9054.366194366332, 9267.67563135287, 9308.534573271309, 9589.280803939733, 534.4441780548264, 579.1081734129477, 697.4350775871459, 713.1834050012707, 713.9643017849087, 3866.2460820140363, 3952.9877520722503, 4090.079732060322, 4130.938035929464, 4135.56576559463, 53574.7321263399, 53816.0, 53837.0, 54291.18563221555, 57724.0, 48226.758866206146, 48299.5170048302, 48963.75518122387, 49442.75278623584, 49647.751761240965, 44937.87655308578, 45420.0, 46090.769546152726, 46563.30155047677, 46985.295220571716, 7871.881921771293, 7876.173001834725, 7938.563379013978, 8203.179682031749, 8222.671093156207, 32751.508727369586, 32929.506057409635, 33393.33213335768, 33432.49851252282, 33576.0, 39829.60170398259, 40618.18763624652, 43607.0, 44404.33393499165, 44539.777301114584, 10200.132988696045, 10285.331453455501, 10293.43386113741, 10297.12474439681, 10323.277370583986, 10707.357558546511, 10805.45972701346, 10951.945240273748, 11048.281861678965, 11286.830697539708, 10273.0, 10343.896561034293, 10419.166466682496, 10445.321054131457, 10607.0, 9728.9027109728, 10007.09936105754, 10050.547725352522, 10282.588696452058, 10371.170306375321, 9573.18627916635, 10194.082532572103, 10450.47747612601, 10502.579896804347, 10551.103156231498, 8121.350291976746, 8157.836843262983, 8271.230287050492, 8297.917020829715, 8743.038265790885, 7491.43814213947, 7672.850755335128, 8157.3474122071275, 8291.917080829115, 8620.568971551524], "unit": "score", "name": "yui.html", "value": 6088.015363176525}], "name": "dromaeo_css", "value": 6848.339125003931}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 108.0, 111.0, 110.0, 113.0, 130.0, 112.0, 111.0, 111.0, 112.0], "unit": "score", "name": "ai-astar", "value": 113.0}, {"lowerIsBetter": true, "replicates": [159.0, 129.0, 152.0, 165.0, 127.0, 175.0, 152.0, 130.0, 172.0, 125.0], "unit": "score", "name": "audio-beat-detection", "value": 148.6}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 162.0, 164.0, 162.0, 161.0, 162.0, 165.0, 165.0, 161.0], "unit": "score", "name": "audio-dft", "value": 162.6}, {"lowerIsBetter": true, "replicates": [74.0, 76.0, 76.0, 73.0, 73.0, 73.0, 138.0, 73.0, 76.0, 73.0], "unit": "score", "name": "audio-fft", "value": 80.5}, {"lowerIsBetter": true, "replicates": [97.0, 98.0, 151.0, 96.0, 97.0, 96.0, 150.0, 98.0, 97.0, 141.0], "unit": "score", "name": "audio-oscillator", "value": 112.1}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 110.0, 110.0, 110.0, 110.0, 111.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.9}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 148.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.4}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 97.0, 97.0, 97.0, 97.0, 97.0, 96.0, 96.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.6}, {"lowerIsBetter": true, "replicates": [60.0, 61.0, 60.0, 57.0, 59.0, 59.0, 60.0, 59.0, 67.0, 60.0], "unit": "score", "name": "json-parse-financial", "value": 60.2}, {"lowerIsBetter": true, "replicates": [74.0, 67.0, 67.0, 68.0, 69.0, 68.0, 68.0, 68.0, 69.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.5}, {"lowerIsBetter": true, "replicates": [83.0, 83.0, 91.0, 82.0, 81.0, 80.0, 84.0, 83.0, 90.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.9}, {"lowerIsBetter": true, "replicates": [123.0, 116.0, 127.0, 129.0, 120.0, 128.0, 119.0, 124.0, 115.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.9}, {"lowerIsBetter": true, "replicates": [144.0, 152.0, 142.0, 145.0, 145.0, 135.0, 148.0, 147.0, 157.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.7}, {"lowerIsBetter": true, "replicates": [69.0, 67.0, 70.0, 66.0, 70.0, 68.0, 68.0, 65.0, 66.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.6}], "name": "kraken", "value": 1517.5000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [169.14749661705008], "unit": "score", "name": "Richards", "value": 208.70542400000005}, {"lowerIsBetter": false, "replicates": [187.2308556450103], "unit": "score", "name": "DeltaBlue", "value": 353.1362380000001}, {"lowerIsBetter": false, "replicates": [279.56388034665923], "unit": "score", "name": "Encrypt", "value": 952.1294369999999}, {"lowerIsBetter": false, "replicates": [5208.333333333333], "unit": "score", "name": "Decrypt", "value": 51.10675199999996}, {"lowerIsBetter": false, "replicates": [1074.1138560687432], "unit": "score", "name": "RayTrace", "value": 688.9297590000002}, {"lowerIsBetter": false, "replicates": [704.7216349541931], "unit": "score", "name": "Earley", "value": 945.7109970000002}, {"lowerIsBetter": false, "replicates": [12345.67901234568], "unit": "score", "name": "Boyer", "value": 53.98350299999995}, {"lowerIsBetter": false, "replicates": [41320.0], "unit": "score", "name": "RegExp", "value": 22.047071636011623}, {"lowerIsBetter": false, "replicates": [590.318772136954], "unit": "score", "name": "Splay", "value": 138.04575399999996}, {"lowerIsBetter": false, "replicates": [4817.307692307692], "unit": "score", "name": "NavierStokes", "value": 308.055888223553}], "name": "v8_7", "value": 20401.664061665135}]} 17:36:21 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "20401.66"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1517.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6848.34"}}} 17:36:21 INFO - Return code: 0 17:36:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 17:36:21 INFO - # TBPL SUCCESS # 17:36:21 INFO - Running post-action listener: _resource_record_post_action 17:36:21 INFO - Running post-run listener: _resource_record_post_run 17:36:22 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 77824; Write bytes: 559063040; Read time: 164; Write time: 466152 17:36:22 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 4096; Write bytes: 244641792; Read time: 0; Write time: 292968 17:36:22 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 73728; Write bytes: 314421248; Read time: 164; Write time: 173184 17:36:22 INFO - Running post-run listener: _upload_blobber_files 17:36:22 INFO - Blob upload gear active. 17:36:22 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 17:36:22 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 17:36:22 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'] 17:36:22 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 17:36:23 INFO - (blobuploader) - INFO - Open directory for files ... 17:36:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:36:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:36:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:36:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:36:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:36:23 INFO - (blobuploader) - INFO - Done attempting. 17:36:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:36:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:36:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:36:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:36:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:36:24 INFO - (blobuploader) - INFO - Done attempting. 17:36:24 INFO - (blobuploader) - INFO - Iteration through files over. 17:36:24 INFO - Return code: 0 17:36:24 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 17:36:24 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 17:36:24 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8b5042b889a7d7abc72a543b79bab2a8bcbae670863347c2314517428e40ff2f786b842e723bb479342377ec01413cf2102c819a251c2ebfedc60e10db58e9fc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d46b377d9e550f848d8db4cb2c985e184c027d3e88173f1a07b264ef311f8695d17a0a4552361ea86b9ef8c31ff3f0321f299f93f0dbe2e9c3e71985f3215f09"} 17:36:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 17:36:24 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 17:36:24 INFO - Contents: 17:36:24 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8b5042b889a7d7abc72a543b79bab2a8bcbae670863347c2314517428e40ff2f786b842e723bb479342377ec01413cf2102c819a251c2ebfedc60e10db58e9fc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d46b377d9e550f848d8db4cb2c985e184c027d3e88173f1a07b264ef311f8695d17a0a4552361ea86b9ef8c31ff3f0321f299f93f0dbe2e9c3e71985f3215f09"} 17:36:24 INFO - Running post-run listener: copy_logs_to_upload_dir 17:36:24 INFO - Copying logs to upload dir... 17:36:24 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 17:36:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.128926 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-01-19 17:36:24.764885) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-19 17:36:24.768442) ========= 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=574dc5aafe09851ec43d388c000001b6-1453251771.124468-664606412 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8b5042b889a7d7abc72a543b79bab2a8bcbae670863347c2314517428e40ff2f786b842e723bb479342377ec01413cf2102c819a251c2ebfedc60e10db58e9fc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d46b377d9e550f848d8db4cb2c985e184c027d3e88173f1a07b264ef311f8695d17a0a4552361ea86b9ef8c31ff3f0321f299f93f0dbe2e9c3e71985f3215f09"} build_url:https://queue.taskcluster.net/v1/task/FD2urM-AT6an-vdyRR3ocQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011192 build_url: 'https://queue.taskcluster.net/v1/task/FD2urM-AT6an-vdyRR3ocQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8b5042b889a7d7abc72a543b79bab2a8bcbae670863347c2314517428e40ff2f786b842e723bb479342377ec01413cf2102c819a251c2ebfedc60e10db58e9fc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d46b377d9e550f848d8db4cb2c985e184c027d3e88173f1a07b264ef311f8695d17a0a4552361ea86b9ef8c31ff3f0321f299f93f0dbe2e9c3e71985f3215f09"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-19 17:36:24.796217) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 17:36:24.796832) ========= 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=574dc5aafe09851ec43d388c000001b6-1453251771.124468-664606412 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004499 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 17:36:24.880194) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-19 17:36:24.880591) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-19 17:36:24.880974) ========= ========= Total master_lag: 0.38 =========