builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-069 starttime: 1453295412.64 results: success (0) buildid: 20160120023011 builduid: 681635a2ce474f5593999a60f26d68d3 revision: c2139fedfe55c5e36d173268eea3aba55467b12f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-20 05:10:12.639117) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-20 05:10:12.639598) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-20 05:10:12.639940) ========= 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=1861a34ebfea852630dec091000001fa-1453295209.804871-1078667273 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006448 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-20 05:10:12.676509) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-20 05:10:12.676829) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-20 05:10:12.691411) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 05:10:12.691703) ========= 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=1861a34ebfea852630dec091000001fa-1453295209.804871-1078667273 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004702 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 05:10:12.743558) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-20 05:10:12.743907) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-20 05:10:12.744258) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 05:10:12.744533) ========= 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=1861a34ebfea852630dec091000001fa-1453295209.804871-1078667273 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-20 05:10:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2016-01-20 05:10:14 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.149054 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 05:10:12.905532) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 05:10:12.905856) ========= 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=1861a34ebfea852630dec091000001fa-1453295209.804871-1078667273 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020160 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 05:10:12.955604) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 05:10:12.956000) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c2139fedfe55c5e36d173268eea3aba55467b12f --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 c2139fedfe55c5e36d173268eea3aba55467b12f --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=1861a34ebfea852630dec091000001fa-1453295209.804871-1078667273 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-20 05:10:14,197 truncating revision to first 12 chars 2016-01-20 05:10:14,197 Setting DEBUG logging. 2016-01-20 05:10:14,198 attempt 1/10 2016-01-20 05:10:14,198 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c2139fedfe55?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-20 05:10:14,453 unpacking tar archive at: fx-team-c2139fedfe55/testing/mozharness/ program finished with exit code 0 elapsedTime=0.557115 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 05:10:13.525621) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-20 05:10:13.525976) ========= 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=1861a34ebfea852630dec091000001fa-1453295209.804871-1078667273 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False %(revision)s program finished with exit code 0 elapsedTime=0.004328 script_repo_revision: '%(revision)s' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-20 05:10:13.575219) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-20 05:10:13.575534) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-20 05:10:13.586244) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-20 05:10:13.586526) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/%(revision)s ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-20 05:10:13.586931) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-01-20 05:10:13.587218) ========= /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=1861a34ebfea852630dec091000001fa-1453295209.804871-1078667273 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:10:14 INFO - MultiFileLogger online at 20160120 05:10:14 in /builds/slave/test-pgo 05:10:14 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 05:10:14 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:10:14 INFO - {'append_to_log': False, 05:10:14 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:10:14 INFO - 'blob_upload_branch': 'Fx-Team', 05:10:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:10:14 INFO - 'branch': 'Fx-Team', 05:10:14 INFO - 'buildbot_json_path': 'buildprops.json', 05:10:14 INFO - 'config_files': ('talos/linux_config.py',), 05:10:14 INFO - 'default_actions': ('clobber', 05:10:14 INFO - 'read-buildbot-config', 05:10:14 INFO - 'download-and-extract', 05:10:14 INFO - 'populate-webroot', 05:10:14 INFO - 'create-virtualenv', 05:10:14 INFO - 'install', 05:10:14 INFO - 'run-tests'), 05:10:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:10:14 INFO - 'download_minidump_stackwalk': True, 05:10:14 INFO - 'download_symbols': 'ondemand', 05:10:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:10:14 INFO - 'tooltool.py': '/tools/tooltool.py', 05:10:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:10:14 INFO - '/tools/misc-python/virtualenv.py')}, 05:10:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:10:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:10:14 INFO - 'installer_path': 'installer.exe', 05:10:14 INFO - 'log_level': 'info', 05:10:14 INFO - 'log_name': 'talos', 05:10:14 INFO - 'log_to_console': True, 05:10:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:10:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:10:14 INFO - 'opt_config_files': (), 05:10:14 INFO - 'pip_index': False, 05:10:14 INFO - 'sps_profile': False, 05:10:14 INFO - 'sps_profile_interval': 0, 05:10:14 INFO - 'suite': 'dromaeojs-e10s', 05:10:14 INFO - 'system_bits': '32', 05:10:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:10:14 INFO - 'title': 'talos-linux64-ix-069', 05:10:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:10:14 INFO - 'use_talos_json': True, 05:10:14 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:10:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:10:14 INFO - 'work_dir': 'build'} 05:10:14 INFO - ##### 05:10:14 INFO - ##### Running clobber step. 05:10:14 INFO - ##### 05:10:14 INFO - Running pre-action listener: _resource_record_pre_action 05:10:14 INFO - Running main action method: clobber 05:10:14 INFO - rmtree: /builds/slave/test-pgo/build 05:10:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:10:15 INFO - Running post-action listener: _resource_record_post_action 05:10:15 INFO - ##### 05:10:15 INFO - ##### Running read-buildbot-config step. 05:10:15 INFO - ##### 05:10:15 INFO - Running pre-action listener: _resource_record_pre_action 05:10:15 INFO - Running main action method: read_buildbot_config 05:10:15 INFO - Using buildbot properties: 05:10:15 INFO - { 05:10:15 INFO - "project": "", 05:10:15 INFO - "product": "firefox", 05:10:15 INFO - "script_repo_revision": "production", 05:10:15 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 05:10:15 INFO - "repository": "", 05:10:15 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 05:10:15 INFO - "buildid": "20160120023011", 05:10:15 INFO - "pgo_build": "True", 05:10:15 INFO - "basedir": "/builds/slave/test-pgo", 05:10:15 INFO - "buildnumber": 225, 05:10:15 INFO - "slavename": "talos-linux64-ix-069", 05:10:15 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:10:15 INFO - "platform": "ubuntu64_hw", 05:10:15 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:10:15 INFO - "branch": "fx-team", 05:10:15 INFO - "repo_path": "integration/fx-team", 05:10:15 INFO - "revision": "c2139fedfe55c5e36d173268eea3aba55467b12f", 05:10:15 INFO - "stage_platform": "linux64-pgo", 05:10:15 INFO - "builduid": "681635a2ce474f5593999a60f26d68d3", 05:10:15 INFO - "slavebuilddir": "test" 05:10:15 INFO - } 05:10:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/aURfFez5SfCqp43oWlq6Ow/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 05:10:15 INFO - Running post-action listener: _resource_record_post_action 05:10:15 INFO - ##### 05:10:15 INFO - ##### Running download-and-extract step. 05:10:15 INFO - ##### 05:10:15 INFO - Running pre-action listener: _resource_record_pre_action 05:10:15 INFO - Running main action method: download_and_extract 05:10:15 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:10:15 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')]} 05:10:15 INFO - https://queue.taskcluster.net/v1/task/aURfFez5SfCqp43oWlq6Ow/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:10:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aURfFez5SfCqp43oWlq6Ow/artifacts/public/build/test_packages.json 05:10:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aURfFez5SfCqp43oWlq6Ow/artifacts/public/build/test_packages.json 05:10:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aURfFez5SfCqp43oWlq6Ow/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 05:10:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aURfFez5SfCqp43oWlq6Ow/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 05:10:23 INFO - Downloaded 1448 bytes. 05:10:23 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 05:10:23 INFO - Using the following test package requirements: 05:10:23 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:10:23 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:10:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:10:23 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:10:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:10:23 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:10:23 INFO - u'jsshell-linux-x86_64.zip'], 05:10:23 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:10:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:10:23 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:10:23 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:10:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:10:23 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:10:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:10:23 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:10:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:10:23 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:10:23 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:10:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:10:23 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:10: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')]} 05:10:23 INFO - https://queue.taskcluster.net/v1/task/aURfFez5SfCqp43oWlq6Ow/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:10:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aURfFez5SfCqp43oWlq6Ow/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:10:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aURfFez5SfCqp43oWlq6Ow/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:10:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aURfFez5SfCqp43oWlq6Ow/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 05:10:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aURfFez5SfCqp43oWlq6Ow/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 05:10:29 INFO - Downloaded 22485832 bytes. 05:10:29 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'] 05:10:29 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 05:10:30 INFO - Return code: 0 05:10:30 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 05:10:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:30 INFO - https://queue.taskcluster.net/v1/task/aURfFez5SfCqp43oWlq6Ow/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:10:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aURfFez5SfCqp43oWlq6Ow/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:10:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aURfFez5SfCqp43oWlq6Ow/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:10:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aURfFez5SfCqp43oWlq6Ow/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 05:10:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aURfFez5SfCqp43oWlq6Ow/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 05:10:31 INFO - Downloaded 22485832 bytes. 05:10:31 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'] 05:10:31 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 05:10:32 INFO - Return code: 0 05:10:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:32 INFO - https://queue.taskcluster.net/v1/task/aURfFez5SfCqp43oWlq6Ow/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:10:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aURfFez5SfCqp43oWlq6Ow/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:10:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aURfFez5SfCqp43oWlq6Ow/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:10:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aURfFez5SfCqp43oWlq6Ow/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 05:10:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aURfFez5SfCqp43oWlq6Ow/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 05:10:33 INFO - Downloaded 11132144 bytes. 05:10:33 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'] 05:10:33 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 05:10:34 INFO - Return code: 0 05:10: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')]} 05:10:34 INFO - https://queue.taskcluster.net/v1/task/aURfFez5SfCqp43oWlq6Ow/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:10:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aURfFez5SfCqp43oWlq6Ow/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:10:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aURfFez5SfCqp43oWlq6Ow/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:10:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aURfFez5SfCqp43oWlq6Ow/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 05:10:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aURfFez5SfCqp43oWlq6Ow/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 05:10:36 INFO - Downloaded 55932189 bytes. 05:10:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aURfFez5SfCqp43oWlq6Ow/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:10:36 INFO - mkdir: /builds/slave/test-pgo/properties 05:10:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:10:36 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:10:36 INFO - Contents: 05:10:36 INFO - build_url:https://queue.taskcluster.net/v1/task/aURfFez5SfCqp43oWlq6Ow/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:10:36 INFO - Running post-action listener: _resource_record_post_action 05:10:36 INFO - Running post-action listener: set_extra_try_arguments 05:10:36 INFO - ##### 05:10:36 INFO - ##### Running populate-webroot step. 05:10:36 INFO - ##### 05:10:36 INFO - Running pre-action listener: _resource_record_pre_action 05:10:36 INFO - Running main action method: populate_webroot 05:10:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:10:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:10:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:10:36 INFO - '--tppagecycles', 05:10:36 INFO - '7'], 05:10:36 INFO - 'tests': ['tsvgm']}}, 05:10:36 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:10:36 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:10:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:10:36 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:10:36 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:10:36 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:10:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:10:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:36 INFO - 'talos_options': ['--e10s'], 05:10:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:10:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:36 INFO - 'tests': ['damp', 'tps']}, 05:10:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:36 INFO - 'talos_options': ['--e10s'], 05:10:36 INFO - 'tests': ['damp', 'tps']}, 05:10:36 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:10:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:10:36 INFO - 'other': {'tests': ['a11yr', 05:10:36 INFO - 'ts_paint', 05:10:36 INFO - 'tpaint', 05:10:36 INFO - 'sessionrestore', 05:10:36 INFO - 'sessionrestore_no_auto_restore']}, 05:10:36 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:10:36 INFO - 'tests': ['a11yr', 05:10:36 INFO - 'ts_paint', 05:10:36 INFO - 'tpaint', 05:10:36 INFO - 'sessionrestore', 05:10:36 INFO - 'sessionrestore_no_auto_restore']}, 05:10:36 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:10:36 INFO - 'tests': ['a11yr', 05:10:36 INFO - 'ts_paint', 05:10:36 INFO - 'tpaint', 05:10:36 INFO - 'sessionrestore', 05:10:36 INFO - 'sessionrestore_no_auto_restore']}, 05:10:36 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:10:36 INFO - 'tests': ['a11yr', 05:10:36 INFO - 'ts_paint', 05:10:36 INFO - 'tpaint', 05:10:36 INFO - 'sessionrestore', 05:10:36 INFO - 'sessionrestore_no_auto_restore']}, 05:10:36 INFO - 'other_l64': {'tests': ['a11yr', 05:10:36 INFO - 'ts_paint', 05:10:36 INFO - 'tpaint', 05:10:36 INFO - 'sessionrestore', 05:10:36 INFO - 'sessionrestore_no_auto_restore']}, 05:10:36 INFO - 'other_nol64': {'tests': ['a11yr', 05:10:36 INFO - 'ts_paint', 05:10:36 INFO - 'tpaint', 05:10:36 INFO - 'sessionrestore', 05:10:36 INFO - 'sessionrestore_no_auto_restore']}, 05:10:36 INFO - 'svgr': {'tests': ['tsvgx', 05:10:36 INFO - 'tsvgr_opacity', 05:10:36 INFO - 'tart', 05:10:36 INFO - 'tscrollx', 05:10:36 INFO - 'cart']}, 05:10:36 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:10:36 INFO - 'tests': ['tsvgx', 05:10:36 INFO - 'tsvgr_opacity', 05:10:36 INFO - 'tart', 05:10:36 INFO - 'tscrollx', 05:10:36 INFO - 'cart']}, 05:10:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:36 INFO - 'tests': ['tp5o']}, 05:10:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:36 INFO - 'talos_options': ['--e10s'], 05:10:36 INFO - 'tests': ['tp5o']}, 05:10:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:36 INFO - 'talos_options': ['--xperf_path', 05:10:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:10:36 INFO - 'tests': ['tp5n']}, 05:10:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:36 INFO - 'talos_options': ['--e10s', 05:10:36 INFO - '--xperf_path', 05:10:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:10:36 INFO - 'tests': ['tp5n']}}, 05:10:36 INFO - 'talos.zip': {'path': '', 05:10:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:10:36 INFO - Running post-action listener: _resource_record_post_action 05:10:36 INFO - ##### 05:10:36 INFO - ##### Running create-virtualenv step. 05:10:36 INFO - ##### 05:10:36 INFO - Running pre-action listener: _resource_record_pre_action 05:10:36 INFO - Running main action method: create_virtualenv 05:10:36 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:10:36 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 05:10:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:10:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:10:36 INFO - Using real prefix '/usr' 05:10:36 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:10:37 INFO - Installing distribute.............................................................................................................................................................................................done. 05:10:39 INFO - Installing pip.................done. 05:10:39 INFO - Return code: 0 05:10:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:10: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')]} 05:10:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10: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')]} 05:10:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:39 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f1a5dc07f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x116d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x123d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ce840>, '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 0x123b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x123bb60>, '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': '1861a34ebfea852630dec091000001fa-1453295209.804871-1078667273', '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 05:10:39 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 05:10:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 05:10:39 INFO - Using env: {'DISPLAY': ':0', 05:10:39 INFO - 'HOME': '/home/cltbld', 05:10:39 INFO - 'LANG': 'en_US.UTF-8', 05:10:39 INFO - 'LANGUAGE': 'en_US:en', 05:10:39 INFO - 'LOGNAME': 'cltbld', 05:10:39 INFO - 'MAIL': '/var/mail/cltbld', 05:10:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:39 INFO - 'MOZ_NO_REMOTE': '1', 05:10:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:39 INFO - 'NO_EM_RESTART': '1', 05:10:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:10:39 INFO - 'PWD': '/builds/slave/test-pgo', 05:10:39 INFO - 'SHELL': '/bin/bash', 05:10:39 INFO - 'SHLVL': '1', 05:10:39 INFO - 'TERM': 'linux', 05:10:39 INFO - 'TMOUT': '86400', 05:10:39 INFO - 'USER': 'cltbld', 05:10:39 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1453295209.804871-1078667273', 05:10:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:39 INFO - '_': '/tools/buildbot/bin/python'} 05:10:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:39 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 05:10:39 INFO - Cleaning up... 05:10:39 INFO - Return code: 0 05:10:39 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:10: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')]} 05:10:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10: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')]} 05:10:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:39 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f1a5dc07f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x116d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x123d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ce840>, '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 0x123b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x123bb60>, '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': '1861a34ebfea852630dec091000001fa-1453295209.804871-1078667273', '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 05:10:39 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 05:10:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 05:10:39 INFO - Using env: {'DISPLAY': ':0', 05:10:39 INFO - 'HOME': '/home/cltbld', 05:10:39 INFO - 'LANG': 'en_US.UTF-8', 05:10:39 INFO - 'LANGUAGE': 'en_US:en', 05:10:39 INFO - 'LOGNAME': 'cltbld', 05:10:39 INFO - 'MAIL': '/var/mail/cltbld', 05:10:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:39 INFO - 'MOZ_NO_REMOTE': '1', 05:10:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:39 INFO - 'NO_EM_RESTART': '1', 05:10:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:10:39 INFO - 'PWD': '/builds/slave/test-pgo', 05:10:39 INFO - 'SHELL': '/bin/bash', 05:10:39 INFO - 'SHLVL': '1', 05:10:39 INFO - 'TERM': 'linux', 05:10:39 INFO - 'TMOUT': '86400', 05:10:39 INFO - 'USER': 'cltbld', 05:10:39 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1453295209.804871-1078667273', 05:10:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:39 INFO - '_': '/tools/buildbot/bin/python'} 05:10:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:39 INFO - Downloading/unpacking psutil>=0.7.1 05:10:39 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 05:10:39 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 05:10:39 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 05:10:39 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 05:10:39 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 05:10:39 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 05:10:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:10:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:10:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:10:41 INFO - Installing collected packages: psutil 05:10:41 INFO - Running setup.py install for psutil 05:10:41 INFO - building 'psutil._psutil_linux' extension 05:10:41 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 05:10:41 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 05:10:41 INFO - building 'psutil._psutil_posix' extension 05:10:41 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 05:10:41 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 05:10:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:10:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:10:41 INFO - Successfully installed psutil 05:10:41 INFO - Cleaning up... 05:10:42 INFO - Return code: 0 05:10:42 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:10: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')]} 05:10:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10: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')]} 05:10:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:42 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f1a5dc07f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x116d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x123d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ce840>, '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 0x123b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x123bb60>, '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': '1861a34ebfea852630dec091000001fa-1453295209.804871-1078667273', '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 05:10:42 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 05:10:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 05:10:42 INFO - Using env: {'DISPLAY': ':0', 05:10:42 INFO - 'HOME': '/home/cltbld', 05:10:42 INFO - 'LANG': 'en_US.UTF-8', 05:10:42 INFO - 'LANGUAGE': 'en_US:en', 05:10:42 INFO - 'LOGNAME': 'cltbld', 05:10:42 INFO - 'MAIL': '/var/mail/cltbld', 05:10:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:42 INFO - 'MOZ_NO_REMOTE': '1', 05:10:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:42 INFO - 'NO_EM_RESTART': '1', 05:10:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:10:42 INFO - 'PWD': '/builds/slave/test-pgo', 05:10:42 INFO - 'SHELL': '/bin/bash', 05:10:42 INFO - 'SHLVL': '1', 05:10:42 INFO - 'TERM': 'linux', 05:10:42 INFO - 'TMOUT': '86400', 05:10:42 INFO - 'USER': 'cltbld', 05:10:42 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1453295209.804871-1078667273', 05:10:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:42 INFO - '_': '/tools/buildbot/bin/python'} 05:10:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:42 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:10:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:43 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:10:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:10:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:10:44 INFO - Installing collected packages: mozsystemmonitor 05:10:44 INFO - Running setup.py install for mozsystemmonitor 05:10:44 INFO - Successfully installed mozsystemmonitor 05:10:44 INFO - Cleaning up... 05:10:44 INFO - Return code: 0 05:10:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:10:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:44 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f1a5dc07f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x116d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x123d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ce840>, '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 0x123b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x123bb60>, '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': '1861a34ebfea852630dec091000001fa-1453295209.804871-1078667273', '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 05:10:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 05:10:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 05:10:44 INFO - Using env: {'DISPLAY': ':0', 05:10:44 INFO - 'HOME': '/home/cltbld', 05:10:44 INFO - 'LANG': 'en_US.UTF-8', 05:10:44 INFO - 'LANGUAGE': 'en_US:en', 05:10:44 INFO - 'LOGNAME': 'cltbld', 05:10:44 INFO - 'MAIL': '/var/mail/cltbld', 05:10:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:44 INFO - 'MOZ_NO_REMOTE': '1', 05:10:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:44 INFO - 'NO_EM_RESTART': '1', 05:10:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:10:44 INFO - 'PWD': '/builds/slave/test-pgo', 05:10:44 INFO - 'SHELL': '/bin/bash', 05:10:44 INFO - 'SHLVL': '1', 05:10:44 INFO - 'TERM': 'linux', 05:10:44 INFO - 'TMOUT': '86400', 05:10:44 INFO - 'USER': 'cltbld', 05:10:44 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1453295209.804871-1078667273', 05:10:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:44 INFO - '_': '/tools/buildbot/bin/python'} 05:10:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:44 INFO - Downloading/unpacking blobuploader==1.2.4 05:10: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 05:10: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 05:10: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 05:10: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 05:10: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 05:10: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 05:10:46 INFO - Downloading blobuploader-1.2.4.tar.gz 05:10:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:10:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:10: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 05:10: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 05:10: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 05:10: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 05:10: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 05:10: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 05:10:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:10:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:10: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 05:10: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 05:10: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 05:10: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 05:10: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 05:10: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 05:10:46 INFO - Downloading docopt-0.6.1.tar.gz 05:10:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:10:46 INFO - Installing collected packages: blobuploader, requests, docopt 05:10:46 INFO - Running setup.py install for blobuploader 05:10:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:10:46 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:10:46 INFO - Running setup.py install for requests 05:10:47 INFO - Running setup.py install for docopt 05:10:47 INFO - Successfully installed blobuploader requests docopt 05:10:47 INFO - Cleaning up... 05:10:47 INFO - Return code: 0 05:10:47 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:10:47 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')]} 05:10:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:47 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')]} 05:10:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:47 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--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 0x7f1a5dc07f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x116d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x123d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ce840>, '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 0x123b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x123bb60>, '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': '1861a34ebfea852630dec091000001fa-1453295209.804871-1078667273', '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 05:10:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--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 05:10:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --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 05:10:47 INFO - Using env: {'DISPLAY': ':0', 05:10:47 INFO - 'HOME': '/home/cltbld', 05:10:47 INFO - 'LANG': 'en_US.UTF-8', 05:10:47 INFO - 'LANGUAGE': 'en_US:en', 05:10:47 INFO - 'LOGNAME': 'cltbld', 05:10:47 INFO - 'MAIL': '/var/mail/cltbld', 05:10:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:47 INFO - 'MOZ_NO_REMOTE': '1', 05:10:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:47 INFO - 'NO_EM_RESTART': '1', 05:10:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:10:47 INFO - 'PWD': '/builds/slave/test-pgo', 05:10:47 INFO - 'SHELL': '/bin/bash', 05:10:47 INFO - 'SHLVL': '1', 05:10:47 INFO - 'TERM': 'linux', 05:10:47 INFO - 'TMOUT': '86400', 05:10:47 INFO - 'USER': 'cltbld', 05:10:47 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1453295209.804871-1078667273', 05:10:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:47 INFO - '_': '/tools/buildbot/bin/python'} 05:10:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:10:47 INFO - Running setup.py (path:/tmp/pip-3dllGs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:10:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:10:47 INFO - Running setup.py (path:/tmp/pip-LQPp_I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:10:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:10:47 INFO - Running setup.py (path:/tmp/pip-xO9bxi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:10:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:10:47 INFO - Running setup.py (path:/tmp/pip-8PQi5R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:10:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:10:47 INFO - Running setup.py (path:/tmp/pip-Q0HW37-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:10:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:10:48 INFO - Running setup.py (path:/tmp/pip-PbNMvV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:10:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:10:48 INFO - Running setup.py (path:/tmp/pip-gaii5Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:10:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:10:48 INFO - Running setup.py (path:/tmp/pip-1QGQVk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:10:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:10:48 INFO - Running setup.py (path:/tmp/pip-JwcgBj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:10:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:10:48 INFO - Running setup.py (path:/tmp/pip-DYXKDG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:10:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:10:48 INFO - Running setup.py (path:/tmp/pip-GtNeut-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:10:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:10:48 INFO - Running setup.py (path:/tmp/pip-EeOn4N-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:10:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:10:48 INFO - Running setup.py (path:/tmp/pip-X_MAGd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:10:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:10:48 INFO - Running setup.py (path:/tmp/pip-O42izm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:10:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:10:48 INFO - Running setup.py (path:/tmp/pip-Nbmeph-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:10:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:10:48 INFO - Running setup.py (path:/tmp/pip-HxoPcP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:10:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:10:48 INFO - Running setup.py (path:/tmp/pip-dMvfxz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:10:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:10:48 INFO - Running setup.py install for manifestparser 05:10:48 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:10:48 INFO - Running setup.py install for mozcrash 05:10:49 INFO - Running setup.py install for mozdebug 05:10:49 INFO - Running setup.py install for mozdevice 05:10:49 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:10:49 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:10:49 INFO - Running setup.py install for mozfile 05:10:49 INFO - Running setup.py install for mozhttpd 05:10:49 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:10:49 INFO - Running setup.py install for mozinfo 05:10:49 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:10:49 INFO - Running setup.py install for mozInstall 05:10:49 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:10:49 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:10:49 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:10:49 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:10:49 INFO - Running setup.py install for mozleak 05:10:49 INFO - Running setup.py install for mozlog 05:10:49 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:10:49 INFO - Running setup.py install for moznetwork 05:10:49 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:10:50 INFO - Running setup.py install for mozprocess 05:10:50 INFO - Running setup.py install for mozprofile 05:10:50 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:10:50 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:10:50 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:10:50 INFO - Running setup.py install for mozrunner 05:10:50 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:10:50 INFO - Running setup.py install for mozscreenshot 05:10:50 INFO - Running setup.py install for moztest 05:10:50 INFO - Running setup.py install for mozversion 05:10:50 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:10:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:10:50 INFO - Cleaning up... 05:10:50 INFO - Return code: 0 05:10:50 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:10:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:50 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f1a5dc07f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x116d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x123d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ce840>, '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 0x123b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x123bb60>, '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': '1861a34ebfea852630dec091000001fa-1453295209.804871-1078667273', '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 05:10:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 05:10:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 05:10:50 INFO - Using env: {'DISPLAY': ':0', 05:10:50 INFO - 'HOME': '/home/cltbld', 05:10:50 INFO - 'LANG': 'en_US.UTF-8', 05:10:50 INFO - 'LANGUAGE': 'en_US:en', 05:10:50 INFO - 'LOGNAME': 'cltbld', 05:10:50 INFO - 'MAIL': '/var/mail/cltbld', 05:10:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:50 INFO - 'MOZ_NO_REMOTE': '1', 05:10:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:50 INFO - 'NO_EM_RESTART': '1', 05:10:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:10:50 INFO - 'PWD': '/builds/slave/test-pgo', 05:10:50 INFO - 'SHELL': '/bin/bash', 05:10:50 INFO - 'SHLVL': '1', 05:10:50 INFO - 'TERM': 'linux', 05:10:50 INFO - 'TMOUT': '86400', 05:10:50 INFO - 'USER': 'cltbld', 05:10:50 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1453295209.804871-1078667273', 05:10:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:50 INFO - '_': '/tools/buildbot/bin/python'} 05:10:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:10:50 INFO - Running setup.py (path:/tmp/pip-Ol8u0h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:10:50 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)) 05:10:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:10:50 INFO - Running setup.py (path:/tmp/pip-oYW7Ro-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:10:51 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)) 05:10:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:10:51 INFO - Running setup.py (path:/tmp/pip-dtyE08-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:10:51 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)) 05:10:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:10:51 INFO - Running setup.py (path:/tmp/pip-H4jeAR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:10:51 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)) 05:10:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:10:51 INFO - Running setup.py (path:/tmp/pip-ouueGW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:10:51 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)) 05:10:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:10:51 INFO - Running setup.py (path:/tmp/pip-bzppGx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:10:51 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)) 05:10:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:10:51 INFO - Running setup.py (path:/tmp/pip-gSCrcM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:10:51 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)) 05:10:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:10:51 INFO - Running setup.py (path:/tmp/pip-bbmsM2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:10:51 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)) 05:10:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:10:51 INFO - Running setup.py (path:/tmp/pip-uLLMIb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:10:51 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)) 05:10:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:10:51 INFO - Running setup.py (path:/tmp/pip-Cv2Xhl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:10:51 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)) 05:10:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:10:51 INFO - Running setup.py (path:/tmp/pip-LAZDgY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:10:51 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)) 05:10:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:10:51 INFO - Running setup.py (path:/tmp/pip-1tdcT6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:10:51 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)) 05:10:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:10:51 INFO - Running setup.py (path:/tmp/pip-E0vWjW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:10:51 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)) 05:10:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:10:51 INFO - Running setup.py (path:/tmp/pip-en4TQX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:10:51 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)) 05:10:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:10:51 INFO - Running setup.py (path:/tmp/pip-0G3VYK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:10:51 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)) 05:10:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:10:51 INFO - Running setup.py (path:/tmp/pip-bP8_5C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:10:52 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)) 05:10:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:10:52 INFO - Running setup.py (path:/tmp/pip-3c8hwo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:10:52 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)) 05:10:52 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)) 05:10:52 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)) 05:10:52 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)) 05:10:52 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)) 05:10:52 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)) 05:10:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:10:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:53 INFO - Downloading blessings-1.5.1.tar.gz 05:10:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:10:54 INFO - Installing collected packages: blessings 05:10:54 INFO - Running setup.py install for blessings 05:10:54 INFO - Successfully installed blessings 05:10:54 INFO - Cleaning up... 05:10:54 INFO - Return code: 0 05:10:54 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:10:54 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:10:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:10:54 INFO - Reading from file tmpfile_stdout 05:10:54 INFO - Current package versions: 05:10:54 INFO - argparse == 1.2.1 05:10:54 INFO - blessings == 1.5.1 05:10:54 INFO - blobuploader == 1.2.4 05:10:54 INFO - docopt == 0.6.1 05:10:54 INFO - manifestparser == 1.1 05:10:54 INFO - mozInstall == 1.12 05:10:54 INFO - mozcrash == 0.16 05:10:54 INFO - mozdebug == 0.1 05:10:54 INFO - mozdevice == 0.48 05:10:54 INFO - mozfile == 1.2 05:10:54 INFO - mozhttpd == 0.7 05:10:54 INFO - mozinfo == 0.9 05:10:54 INFO - mozleak == 0.1 05:10:54 INFO - mozlog == 3.1 05:10:54 INFO - moznetwork == 0.27 05:10:54 INFO - mozprocess == 0.22 05:10:54 INFO - mozprofile == 0.28 05:10:54 INFO - mozrunner == 6.11 05:10:54 INFO - mozscreenshot == 0.1 05:10:54 INFO - mozsystemmonitor == 0.0 05:10:54 INFO - moztest == 0.7 05:10:54 INFO - mozversion == 1.4 05:10:54 INFO - psutil == 3.1.1 05:10:54 INFO - requests == 1.2.3 05:10:54 INFO - wsgiref == 0.1.2 05:10:54 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:10:54 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')]} 05:10:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:54 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')]} 05:10:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:54 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f1a5dc07f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x116d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x123d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ce840>, '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 0x123b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x123bb60>, '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': '1861a34ebfea852630dec091000001fa-1453295209.804871-1078667273', '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 05:10:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 05:10:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 05:10:54 INFO - Using env: {'DISPLAY': ':0', 05:10:54 INFO - 'HOME': '/home/cltbld', 05:10:54 INFO - 'LANG': 'en_US.UTF-8', 05:10:54 INFO - 'LANGUAGE': 'en_US:en', 05:10:54 INFO - 'LOGNAME': 'cltbld', 05:10:54 INFO - 'MAIL': '/var/mail/cltbld', 05:10:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:54 INFO - 'MOZ_NO_REMOTE': '1', 05:10:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:54 INFO - 'NO_EM_RESTART': '1', 05:10:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:10:54 INFO - 'PWD': '/builds/slave/test-pgo', 05:10:54 INFO - 'SHELL': '/bin/bash', 05:10:54 INFO - 'SHLVL': '1', 05:10:54 INFO - 'TERM': 'linux', 05:10:54 INFO - 'TMOUT': '86400', 05:10:54 INFO - 'USER': 'cltbld', 05:10:54 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1453295209.804871-1078667273', 05:10:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:54 INFO - '_': '/tools/buildbot/bin/python'} 05:10:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:54 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)) 05:10:54 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)) 05:10:54 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)) 05:10:54 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)) 05:10:54 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)) 05:10:54 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)) 05:10:54 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)) 05:10:54 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)) 05:10:54 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)) 05:10:54 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)) 05:10:54 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)) 05:10:54 INFO - Cleaning up... 05:10:54 INFO - Return code: 0 05:10:54 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 05:10:54 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')]} 05:10:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:54 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')]} 05:10:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:54 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f1a5dc07f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x116d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x123d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ce840>, '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 0x123b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x123bb60>, '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': '1861a34ebfea852630dec091000001fa-1453295209.804871-1078667273', '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 05:10:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 05:10:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 05:10:54 INFO - Using env: {'DISPLAY': ':0', 05:10:54 INFO - 'HOME': '/home/cltbld', 05:10:54 INFO - 'LANG': 'en_US.UTF-8', 05:10:54 INFO - 'LANGUAGE': 'en_US:en', 05:10:54 INFO - 'LOGNAME': 'cltbld', 05:10:54 INFO - 'MAIL': '/var/mail/cltbld', 05:10:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:54 INFO - 'MOZ_NO_REMOTE': '1', 05:10:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:54 INFO - 'NO_EM_RESTART': '1', 05:10:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:10:54 INFO - 'PWD': '/builds/slave/test-pgo', 05:10:54 INFO - 'SHELL': '/bin/bash', 05:10:54 INFO - 'SHLVL': '1', 05:10:54 INFO - 'TERM': 'linux', 05:10:54 INFO - 'TMOUT': '86400', 05:10:54 INFO - 'USER': 'cltbld', 05:10:54 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1453295209.804871-1078667273', 05:10:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:54 INFO - '_': '/tools/buildbot/bin/python'} 05:10:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:55 INFO - Downloading/unpacking jsonschema 05:10:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:10:56 INFO - Downloading/unpacking functools32 (from jsonschema) 05:10:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:56 INFO - Downloading functools32-3.2.3-2.tar.gz 05:10:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 05:10:57 INFO - warning: no files found matching '*.txt' 05:10:57 INFO - no previously-included directories found matching 'build' 05:10:57 INFO - no previously-included directories found matching 'dist' 05:10:57 INFO - no previously-included directories found matching '.git*' 05:10:57 INFO - Installing collected packages: jsonschema, functools32 05:10:57 INFO - Running setup.py install for functools32 05:10:57 INFO - warning: no files found matching '*.txt' 05:10:57 INFO - no previously-included directories found matching 'build' 05:10:57 INFO - no previously-included directories found matching 'dist' 05:10:57 INFO - no previously-included directories found matching '.git*' 05:10:57 INFO - Successfully installed jsonschema functools32 05:10:57 INFO - Cleaning up... 05:10:57 INFO - Return code: 0 05:10:57 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 05:10:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f1a5dc07f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x116d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x123d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ce840>, '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 0x123b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x123bb60>, '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': '1861a34ebfea852630dec091000001fa-1453295209.804871-1078667273', '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 05:10:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 05:10:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 05:10:57 INFO - Using env: {'DISPLAY': ':0', 05:10:57 INFO - 'HOME': '/home/cltbld', 05:10:57 INFO - 'LANG': 'en_US.UTF-8', 05:10:57 INFO - 'LANGUAGE': 'en_US:en', 05:10:57 INFO - 'LOGNAME': 'cltbld', 05:10:57 INFO - 'MAIL': '/var/mail/cltbld', 05:10:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:57 INFO - 'MOZ_NO_REMOTE': '1', 05:10:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:57 INFO - 'NO_EM_RESTART': '1', 05:10:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:10:57 INFO - 'PWD': '/builds/slave/test-pgo', 05:10:57 INFO - 'SHELL': '/bin/bash', 05:10:57 INFO - 'SHLVL': '1', 05:10:57 INFO - 'TERM': 'linux', 05:10:57 INFO - 'TMOUT': '86400', 05:10:57 INFO - 'USER': 'cltbld', 05:10:57 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1453295209.804871-1078667273', 05:10:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:57 INFO - '_': '/tools/buildbot/bin/python'} 05:10:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:57 INFO - Downloading/unpacking flake8 05:10:57 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 05:10:57 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 05:10:57 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 05:10:57 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 05:10:57 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 05:10:57 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 05:10:59 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:10:59 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:10:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:59 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:10:59 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:10:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:59 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:10:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 05:10:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:10:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:10:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:10:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:10:59 INFO - no previously-included directories found matching 'docs/_build' 05:10:59 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:10:59 INFO - Running setup.py install for pep8 05:10:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:10:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:10:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:10:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:10:59 INFO - no previously-included directories found matching 'docs/_build' 05:11:00 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 05:11:00 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:11:00 INFO - Cleaning up... 05:11:00 INFO - Return code: 0 05:11:00 INFO - Running post-action listener: _resource_record_post_action 05:11:00 INFO - Running post-action listener: _start_resource_monitoring 05:11:00 INFO - Starting resource monitoring. 05:11:00 INFO - ##### 05:11:00 INFO - ##### Running install step. 05:11:00 INFO - ##### 05:11:00 INFO - Running pre-action listener: _resource_record_pre_action 05:11:00 INFO - Running main action method: install 05:11:00 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:11:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:11:00 INFO - Reading from file tmpfile_stdout 05:11:00 INFO - Detecting whether we're running mozinstall >=1.0... 05:11:00 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:11:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:11:00 INFO - Reading from file tmpfile_stdout 05:11:00 INFO - Output received: 05:11:00 INFO - Usage: mozinstall [options] installer 05:11:00 INFO - Options: 05:11:00 INFO - -h, --help show this help message and exit 05:11:00 INFO - -d DEST, --destination=DEST 05:11:00 INFO - Directory to install application into. [default: 05:11:00 INFO - "/builds/slave/test-pgo"] 05:11:00 INFO - --app=APP Application being installed. [default: firefox] 05:11:00 INFO - mkdir: /builds/slave/test-pgo/build/application 05:11:00 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'] 05:11:00 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 05:11:16 INFO - Reading from file tmpfile_stdout 05:11:16 INFO - Output received: 05:11:16 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:11:16 INFO - Running post-action listener: _resource_record_post_action 05:11:16 INFO - ##### 05:11:16 INFO - ##### Running run-tests step. 05:11:16 INFO - ##### 05:11:16 INFO - Running pre-action listener: _resource_record_pre_action 05:11:16 INFO - Running main action method: run_tests 05:11:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:11:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:11:16 INFO - Python 2.7.3 05:11:16 INFO - Return code: 0 05:11:16 INFO - grabbing minidump binary from tooltool 05:11: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')]} 05:11:16 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 0x12ce840>, '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 0x123b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x123bb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:11:16 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 05:11:16 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 05:11:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:11:16 INFO - Return code: 0 05:11:16 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:11:16 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:11:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:11:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:11:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:11:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 05:11:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 05:11:17 INFO - Return code: 0 05:11:17 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/aURfFez5SfCqp43oWlq6Ow/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--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 05:11:17 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/aURfFez5SfCqp43oWlq6Ow/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-069 --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 05:11:17 INFO - Using env: {'DISPLAY': ':0', 05:11:17 INFO - 'HOME': '/home/cltbld', 05:11:17 INFO - 'LANG': 'en_US.UTF-8', 05:11:17 INFO - 'LANGUAGE': 'en_US:en', 05:11:17 INFO - 'LOGNAME': 'cltbld', 05:11:17 INFO - 'MAIL': '/var/mail/cltbld', 05:11:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:11:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:11:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:17 INFO - 'MOZ_NO_REMOTE': '1', 05:11:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:11:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:17 INFO - 'NO_EM_RESTART': '1', 05:11:17 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:11:17 INFO - 'PWD': '/builds/slave/test-pgo', 05:11:17 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:11:17 INFO - 'SHELL': '/bin/bash', 05:11:17 INFO - 'SHLVL': '1', 05:11:17 INFO - 'TERM': 'linux', 05:11:17 INFO - 'TMOUT': '86400', 05:11:17 INFO - 'USER': 'cltbld', 05:11:17 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1453295209.804871-1078667273', 05:11:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:17 INFO - '_': '/tools/buildbot/bin/python'} 05:11:17 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/aURfFez5SfCqp43oWlq6Ow/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--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 05:11:17 INFO - mozversion application_buildid: 20160120023011 05:11:17 INFO - mozversion application_changeset: c2139fedfe55c5e36d173268eea3aba55467b12f 05:11:17 INFO - mozversion application_display_name: Nightly 05:11:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:11:17 INFO - mozversion application_name: Firefox 05:11:17 INFO - mozversion application_remotingname: firefox 05:11:17 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:11:17 INFO - mozversion application_vendor: Mozilla 05:11:17 INFO - mozversion application_version: 46.0a1 05:11:17 INFO - mozversion platform_buildid: 20160120023011 05:11:17 INFO - mozversion platform_changeset: c2139fedfe55c5e36d173268eea3aba55467b12f 05:11:17 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:11:17 INFO - mozversion platform_version: 46.0a1 05:11:17 INFO - using testdate: 1453295477 05:11:17 INFO - actual date: 1453295477 05:11:17 INFO - starting webserver on 'localhost:40141' 05:11:17 INFO - SUITE-START | Running 3 tests 05:11:17 INFO - TEST-START | dromaeo_css 05:11:17 INFO - operating with platform_type : linux_ 05:11:17 INFO - Initialising browser for dromaeo_css test... 05:11:17 INFO - TEST-INFO | started process 15361 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp_ZGSlq/profile http://localhost:40141/getInfo.html) 05:11:21 INFO - PROCESS | 15361 | 05:11:21 INFO - PROCESS | 15361 | (process:15442): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:11:22 INFO - PROCESS | 15361 | __metrics Screen width/height:1600/1200 05:11:22 INFO - PROCESS | 15361 | colorDepth:24 05:11:22 INFO - PROCESS | 15361 | Browser inner width/height: 1024/697 05:11:22 INFO - PROCESS | 15361 | __metrics 05:11:22 INFO - PROCESS | 15361 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:11:23 INFO - TEST-INFO | 15361: exit 0 05:11:23 INFO - Browser initialized. 05:11:23 INFO - Running cycle 1/1 for dromaeo_css test... 05:11:23 INFO - TEST-INFO | started process 15491 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp_ZGSlq/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:11:24 INFO - PROCESS | 15491 | -- checkerboarding starts below -- 05:11:24 INFO - PROCESS | 15491 | RENDERTRACE 0.039553 rect red 0 0 10 10 // viewport 05:11:24 INFO - PROCESS | 15491 | RENDERTRACE 3.76188 rect red 0 0 10 10 // viewport 05:11:24 INFO - PROCESS | 15491 | RENDERTRACE 21.4024 rect brown 0 0 10 10 // page 05:11:24 INFO - PROCESS | 15491 | RENDERTRACE 21.4249 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 05:11:24 INFO - PROCESS | 15491 | Checkerboarded for 2 frames (36.9961 ms), 100 peak, 375 severity. 05:11:25 INFO - PROCESS | 15491 | 05:11:25 INFO - PROCESS | 15491 | (process:15548): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:11:35 INFO - PROCESS | 15491 | RSS: Main: 149983232 05:11:35 INFO - PROCESS | 15491 | 05:12:25 INFO - PROCESS | 15491 | 1453295545163 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] 05:14:33 INFO - PROCESS | 15491 | Cycle 1(1): loaded http://localhost:40141/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40141/tests/dromaeo/cssquery-ext.html) 05:14:34 INFO - PROCESS | 15491 | RSS: Main: 155918336 05:14:34 INFO - PROCESS | 15491 | 05:17:36 INFO - PROCESS | 15491 | Cycle 1(1): loaded http://localhost:40141/tests/dromaeo/cssquery-ext.html (next: http://localhost:40141/tests/dromaeo/cssquery-jquery.html) 05:17:37 INFO - PROCESS | 15491 | RSS: Main: 150790144 05:17:37 INFO - PROCESS | 15491 | 05:20:39 INFO - PROCESS | 15491 | Cycle 1(1): loaded http://localhost:40141/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40141/tests/dromaeo/cssquery-mootools.html) 05:20:39 INFO - PROCESS | 15491 | RSS: Main: 151392256 05:20:39 INFO - PROCESS | 15491 | 05:23:41 INFO - PROCESS | 15491 | Cycle 1(1): loaded http://localhost:40141/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40141/tests/dromaeo/cssquery-prototype.html) 05:23:42 INFO - PROCESS | 15491 | RSS: Main: 150958080 05:23:42 INFO - PROCESS | 15491 | 05:26:44 INFO - PROCESS | 15491 | Cycle 1(1): loaded http://localhost:40141/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40141/tests/dromaeo/cssquery-yui.html) 05:26:45 INFO - PROCESS | 15491 | RSS: Main: 151887872 05:26:45 INFO - PROCESS | 15491 | 05:29:47 INFO - PROCESS | 15491 | Cycle 1(1): loaded http://localhost:40141/tests/dromaeo/cssquery-yui.html (next: http://localhost:40141/tests/dromaeo/cssquery-dojo.html) 05:29:47 INFO - PROCESS | 15491 | RSS: Main: 153391104 05:29:47 INFO - PROCESS | 15491 | 05:29:47 INFO - PROCESS | 15491 | __start_tp_report 05:29:47 INFO - PROCESS | 15491 | _x_x_mozilla_page_load 05:29:47 INFO - PROCESS | 15491 | _x_x_mozilla_page_load_details 05:29:47 INFO - PROCESS | 15491 | |i|pagename|runs| 05:29:48 INFO - PROCESS | 15491 | |0;dojo.html;3085.5834462347575;3097.7831551791373;3118.2048577612704;3134;3159.194405426616;5066.721330326831;5105.489451054893;5117.718525481102;5144.588432925367;5165.30268413764;5124.487551244873;5129.076766182095;5169.870753231171;5203.063448579254;5225.843224703255;4430.5126436092005;4697.835575754849;4833.29917162013;4834.734089625069;4843.854684359475;4749.810007599692;4769;4807.206810876219;4820;4821.180399332122;4731.33761273422;4731.36126622905;4743.35964644772;4821.132196204681;4832.275158726202;4750.477447480775;4755.310479980383;4767.76161191939;4787.018661174451;4809.062232864593;4677.251639737659;4746.952530474686;4770.570648641639;4778.068276686047;4778.761061946923;4946.40643122824;4993.300937868701;5004.724740139291;5021.246812978083;5050.4697006814495;5492.725363731797;5513.09034009388;5520.365158006841;5551.694656793875;5565.6104072714925;5473.233747275384;5510.889782204374;5551.9722401388135;5579.972100139514;5642.576806739511;5126.487351264881;5258.92111618326;5300.3639563252655;5305.44292849253;5358.624896257264;5632.85917852057;5633;5639.464250896158;5666.490015898589;5690.5447564194765;5410.97294513525;5461.481159289861;5468.37113731918;5481.616286859961;5543.334799824047;5547.8890422192135;5611.6071874969175;5614.354349249888;5628.465295796893;5673.120666296731;5425.728713564385;5440.863978400572;5447.754851031713;5451.863703407367;5454.290942177571;5457.2359869618285;5463.972680136653;5465.754041068161;5530.640508366943;5577.776888924479;4328.242557552416;4371.737695738266;4373.059792144704;4400.977995110004;4409.096135292258;3881.146147847469;3881.573026967031;3891.5330160380936;3893.6301051400073;3943.881683549498;5150.819721309811;5163.044836705221;5258;5304.761285742151;5338.626296159309;5554.166874968787;5579.776808927679;5601.131824567198;5603.075492543685;5661.915071273934;5247.10799164143;5256.159014557652;5268.104422248227;5272.420033796279;5309.681419114788;4674.158651442773;4750.07373562152;4764.6664733469015;4786.712797232108;4802.783874725646;5778.826635200867;5815.302163740378;5874.383189765013;5876;5923.6149650273455;5535.778568857281;5541.972290138524;5546.195801608825;5571.777128914798;5574.498295153456;5643.661380317194;5739.684317362585;5784.7107644618445;5786.30564332266;5815.41845815415;5495.725213739377;5496.917546236729;5503.642263252876;5508.889822203613;5565.16522521625;5590.8043218487155;5607.663540187602;5609.80365687199;5615.7192140392;5617.073182924772;5463.426340234377;5468.781248750005;5469.07025805606;5471.23402723627;5475.945240547543;5315.973420132875;5436.184572314026;5450.05602768664;5464.754086066216;5502.532284755841;5336.573074153981;5340.679559226459;5341.439148889466;5361.839144825662;5374.247605335335;5420.430854760351;5436.8640783979135;5464.453554644663;5475.72621368922;5518.2826232589505;5287.788488460418;5314.760835762478;5375.865603359791;5376.301080859464;5377.569794416359 05:29:48 INFO - PROCESS | 15491 | |1;ext.html;503.3255437713463;531.3862488825407;543.6058857328435;568.1591244957463;569.985750356241;39338.213235735304;39573.80213098931;39854.80072599633;39871.601283987155;40000.39999400008;44219.557804421944;44647.33029004568;44850;45273.54726452735;45358.54641453584;8646.481211127353;8779.736607901774;8798.164174403422;8819.162179592928;8827.161419665154;8558.186972237658;8662.566871656423;8679.566021698922;8715.607797649121;8717.910261217348;8618.78453038676;8743.300535957109;8756.03683594804;8761.780955476132;8787.0334263231;8576.742697719048;8621.913780862174;8677.522736249504;8684.782880427976;8724.1712037357;8575.614097365633;8678.481265778526;8749.650013999433;8753.7811554711;8769.517676527788;39299.60700392988;40100;40291.395629065584;40312;40433.797831010655;2711.240852561286;2757.420941602266;2953.8080024798533;3222.146131275214;3738.140227747606;27122.050728224614;27313.726862731517;28614.856925715445;28688.13935581936;28838.855805721047;3909.6285852843935;3943.4479172915526;3996.3805610130476;4045.4740883685226;4066.5323487798987;218930;220959.89520052457;221349;221420;222259;42798.57201427946;43107;43486.565134348886;56658;57078.7146064267;41229.38155927663;41592.37611435831;41613.79193104015;41619.37570936439;41777;13536.661583460493;13593.456261749618;13625.659358516117;13671.931640341734;13696;10682.145428365711;10707.678769636768;10739.409332486632;10780.245382823126;10797.676069717922;14317.284135793168;14334.784978225334;14467.78298325526;14505.274736263145;14567.854321456862;5737.5983681141915;5766;5825.825225243249;5826.1552074948895;5916.112583112482;948.4830767231875;961.4423634292094;1047.5966752800075;1061.686802393296;1100.763335882789;28373.290667733472;29017.56473652897;29065;29259.268518287212;29399;1015.3907655406697;1047.6804574604819;1071.127872740039;1086.7935092332432;1094.414488248783;14504.419823206954;14639.121652700873;14685.559433216808;14812.407503699947;14851.851481485046;383883;384964;385977;388293;389541;54334.72832635811;54694.72652636791;54876;54878.725606372514;54939;1339.6583871112805;1352.0400515633814;1360.1634994478325;1362.203111179951;1365.3924003818404;25618.487630247662;27226.45547089087;27379.452410952068;27414.451710966066;32264;50251.24623130729;50736.49263507318;50980.490195097576;50987;51164;298232;298727;302507;302551;303183;41636;42952.134307912434;44597;44616;44695.329570057125;39548.40677389899;40486.392704108875;40610.1877962445;40701.796491017354;40809.59190408058;33899;34467.4829877547;34635;34725.30549389048;34806.303873921875;34554.65445345514;34666.306673866886;34741;35003.124921877155;35199.64800351964;35461.82269088638;35617.82191089028;35725.821370892976;35746.28507429785;36093.63906361008;31747.36505269928;32357.35285294328;32398.35203295968;32429.35141297208;32572;24494.75505244996;24547.263582092564;24613.507729844943;24978.75021249837;25132.74867251304 05:29:48 INFO - PROCESS | 15491 | |2;jquery.html;350.64584769382924;351.595664985267;360.1769955651337;360.41792505104246;365.34785408046645;15615.84384156158;16301.592460188487;17079.316827326922;17640;17846.732299015493;15630.843691563081;15653.373865045385;15656.608584785386;16329.101899395528;16334.34662613494;4780.737059461728;4937.160682683934;4938.901221975559;4983.078130545842;4989.57588604969;4887.1447496688115;4915.115279249751;4977.3529441172595;5276.076686579852;5362.329708786402;5339.5728341732765;5347.491988261128;5414.7834086636485;5600.635958662694;5624.465675760816;5468.425815289397;5582;5615.943840561583;5924.97037514814;6008.3390827009;5347.278117454132;5348;5349.839504814861;5363.651362661414;5366.302380690485;16687;19187;19626.803731962784;20460.38618841437;20503.589928201352;2028.6754119340835;2032.4106009257298;2091.884946327951;2114.98942505288;2119.4171602809197;9223.53882305882;9310.767230819216;9546.284028697806;9560.665376711851;12606.621801345975;1646.6212771062724;1752.50053734685;1759.7976232733145;1779.946601601954;1875.8968256745873;56425.11595431633;57536.42463575352;57579.136312955336;57738.42261577372;58502.41497585012;9965.451900145561;10001;10161.695149145537;10165;10274.383536987805;12995.870041299655;13148.539801106916;13177.693903566838;13209.603711888658;13229.73540529184;7215.783526494213;7271.63641817907;7313.195548489662;7321.816954576072;7413.4810563261135;6907.963805429225;6937.271586483447;6974.163100427981;6994.125734283215;6996.090508233999;4358.978205108954;4430.091831174602;4438.644908407319;4444.888877778017;4465.263231566755;1822.1800189914327;1830.2678928428736;1906.1422359938083;1911.9330823421114;1920.6542822291842;888.9466632002101;983.8622592837008;989.7773001074701;997.5560875410517;1010.5957616953131;16107.677846443006;16148.919255403884;16580.17099145062;16713.665726685398;16988.235529400958;927.5686805635412;950.1923365139576;954.4416516337881;986.7681094942683;990.8018396320765;9428.292878034037;9571.569279382444;9583.664571739955;9689.757756056155;9831.066048725359;474637;475352;476598;482684;515665;69844.6507767458;71603.28396715966;71804;73645;73915;1111.1000089927186;1114.4873358255131;1153.6020073074776;1165.8659254185877;1169.351010189336;14206.147631142165;14572.927135364256;14687.339069741674;14790.704185916436;15036.473723419627;30650.233744156576;30860.69139308668;31209.219769505944;32173.67826321707;32205.033848984567;36735.448968264966;36777.448338274415;37090.814545927096;37233.81383093176;37609.43585846269;6873.175218973755;7023.384621536973;7058.400035996998;7184.8922266165;7233.855322893407;8515.74452766418;10495.160387168855;10557.63048293306;10654.8934510657;10838.945805270923;7760.6895724172655;9494.382865113745;9710.563024664048;9769.902300976899;9916.75208119774;9027.684031058881;9189.402688825205;9618.903810961801;9834.655787047419;10153.441560713936;8686.706253090108;8843.425177363451;9468.905310947079;9868.210543156387;9921.206303495848;6811.421029212573;6893.827654308682;7118.181409138016;7197.46019048563;7219;8526.616302266537;8912.287017038492;9139.543022848964;9408.764780880532;9609.135177833748 05:29:48 INFO - PROCESS | 15491 | |3;mootools.html;1457.4898785425103;1464.4654701034126;1650.183159336128;1792.1308165539704;1839.181564203928;7725.9613701931485;7740.72907448238;7865.174156713534;7916.366690664748;7937.047554293478;7895.447318687694;7931.36549076074;8000.359971202304;8011.63947622357;8040.477368971013;2312.583734927712;2315.2591170825344;2316.6293393057113;2324.418895276181;2330.359151233416;2348.295511346598;2351.6825228594093;2389.9880500597474;2391.3184742348435;2397.832151749378;2199.9340019799433;2248.775122487746;2256.7291924969027;2332.463533387322;2333.778291062355;2305.596520608895;2329.7320808107115;2347.612643913752;2355.9057637694473;2357.2456813819585;2374.3945293950105;2377.3105799318178;2382.7617238276207;2384.356223819559;2385.2844146755906;7666.769996900046;7669.539827610305;7718.305352518244;7723.0732312122345;7732.884006739903;4766.523347665206;4892.584130348924;4899.216125419915;4913.852584422473;4937.1606826839525;3230.547723318737;3265.6081270247723;3296.76922615417;3297.917552061194;3335.7831740936763;984.547108330169;986.3588667366198;1129.4070612928197;1140.9372484513349;1166.9474873630706;10685.572577096907;10755.677329680122;10767.084797792275;10783.08343790771;10847.186461015377;4179.832806687759;4246.893827654333;4289.849855255114;4315.115401342718;4331.263685173528;8716.564171791386;8846.646134154691;8857.557122143997;8858.86711699325;8865.778355541162;4846.273059041101;4874.8050077997195;4880.414350277918;4881.975590122027;4886.877828054327;4411.20598292304;4426.690131690815;4435.046465010038;4466.196084704784;4486.7083639563325;3546.769459985093;3617.764845285048;3617.963820361815;3620.5474315710535;3659.0486473517076;1106.446776611694;1119.216548416112;1125.983110253347;1134.2854001978865;1156.19066653343;1338.5315139701222;1339.5713371721151;1369.5343583181766;1376.9449222031008;1381.1436909116412;7307.634618269171;7361.521501102411;7437.85124297511;7438.479306448497;7501.887471687929;1120.3781901045;1121.1423261205184;1121.8653761548503;1150.2350936627217;1157.8784227656142;5724.484796368347;5765.88468230633;5797.304323481209;5831.212786273799;5838.241028666331;8819.955900220459;8847.69033083839;9076.500792456478;9078.046805085503;9110.59002344896;8982.910170898338;9075.500847453453;9105.635774569075;9114.13415725505;9142.81714365709;6959.930400696029;7030.753923612649;7103.396211322096;7140.393066589294;7192.964035179686;7210.531315464478;7237.095363079615;7305.305995930378;7325.743598974011;7427.331540161412;8204.753857384288;8231;8386.993560772746;8464.195901389357;8499.320054395757;8528.701495447629;8599.570021499025;8610.741677749678;8649.789029535745;8668.523231222343;7200.099987501562;7514.774556763306;7549.547027178387;7564.810879728051;7596.96201519011;7421;7486.101667799899;7502.962485187539;7541.283578060075;7543.698252069856;6445.838854028687;6815.488838337045;6998.860022799618;7292.486304318913;7295.927040729524;6817.5909445433435;6870.3473170048765;6930.445564354739;6970.79087627372;7006.509544331848;6922.169339679271;6939.930600693929;6985.476089293425;6991.300869912968;6999.020137180697;6201.844953876189;6410.487161027013;6414.262359828679;6416.7754128605275;6417.582857114273;6496.967515162394;6503.6097834130105;6510.21877374718;6515.0553169791065;6668.733250669919 05:29:48 INFO - PROCESS | 15491 | |4;prototype.html;322.5919212196572;330.33272788966286;332.9300846822167;351.5271959214855;358.06723485320725;6190.597611155272;6268.717907694153;6289.119523266746;6291.0563415487695;6399.712012959416;6202.534809889254;6238.4385405313515;6246.469050130733;6254.593451425654;6263;4740.90518189636;4742.241241401376;4779.64152688548;4784.66507344486;4787.0904528139545;4789.3294938708605;4804.711717296974;4806.615470762348;4807.711537307755;4812.037592481518;4682.41469816273;4735.455422626407;4744.97627511862;4746.1931471649905;4755.9286610700865;4726.645501587394;4731.597814185781;4737.976310118462;4738.810447582093;4748.169070412664;4108.856190033334;4112.198121366335;4113.1568028554375;4114.7119701620895;4116.444280022189;5966;5976.611520251213;5977.98374276374;5982.880342393171;5985.9401405986255;5399.919001214985;5497.8075767347955;5501.642393244466;5504.146857237135;5509.504144626962;6632.535722499427;6634.004899265101;6635.336466353374;6642.701078451481;6650.434713049397;4525.660575456854;4526.411566496367;4530.682852200347;4531.139083574143;4540.636749060067;6656.267810540837;6826.351496607815;6851.109355783766;6878.931210687929;6902.344277293649;4662.090892275974;4688.2733176357715;4688.906221875612;4690.061987602493;4694.530546945278;4746.881327966759;4773.498782627774;4782.6173906088125;4790.113828941657;4795.568398844121;5453.727313634303;5496.560275177976;5512;5516.834494965157;5520.779168833282;6502.837429064311;6613.900791488131;6624.403803657694;6625.7680981166395;6630.237522684856;1665.4753752567901;1675.4136052381812;1721.5610019445212;1726.4993151986034;1726.913654317279;1180.2859270141612;1183.5088438298183;1185.8458400407892;1187.0681515010847;1197.5449329254827;6200.534959878028;6211.068339749074;6218.502519798405;6222.253329600477;6223.408776166257;6674.83312917181;6683.465322774166;6701.765438209737;6731.427828634523;6749.257581666013;6058;6168.537359698041;6170.475509581735;6186.628802271788;6205.844853878689;3618.3848745713294;3646.6535679110443;3659.5608526976935;3663.6336366363153;3679.8712045078296;7003.194632617212;7031.050808140938;7038.401735852408;7041.436685065182;7089.361957423856;6715.160604924385;6874.9656251718425;6891.724331026803;6902;6905.827354316082;6979.546329488567;7015.193252775894;7020.403265722369;7020.964895175492;7041.507094503438;6724.394804467622;6738.191417029791;6739.359760822714;6751.898721519279;6762.8647427052165;6494.058361537645;6631.469482441489;6638.966805165944;6655.700493477902;6704.932950670431;6988.860222795617;7018.964905175441;7043.436525078084;7058.400035996792;7069.646517674199;4787.090452814094;4807.278908163804;4827.324174615486;4827.493113223201;4831.202851529459;6629;6654.700538475877;6688.197416310074;6735.595864248161;6884.793456196322;6668.933310667026;6693.933060669331;6720.32796720324;6721.899171512529;6727.93272067273;6603.075569420381;6627;6635.037919501742;6636.701348439428;6665.933340666531;6423.389777971085;6477.255115661759;6533.346665333429;6550.901736473861;6559.934400655932;6684.866302674017;6702.430293424918;6706.5640733352175;6709.698063587248;6716.83207919806;6550.705218265094;6554.246261679968;6560.114384558024;6560.704768285344;6568.770093046721 05:29:48 INFO - PROCESS | 15491 | |5;yui.html;826.5536610230475;827.3257295304327;828.908820029797;836.0844874862024;837.2172019162083;13389.464421423156;13406.329683515822;13491.39288732007;13495.325233738298;13566.186028838276;12922.612321630366;12924.612261632143;12996.805047924288;13032.869671303284;13063.542776002818;660.712590023339;670.4368330602293;801.7714951238898;831.1812864328631;833.8832563441123;820.9876851847197;824.2169938558363;826.8553003224412;829.5810615639124;830.2901019628222;852.4118358332762;853.117023880284;857.4212406625534;859.5616235719765;863.753830158405;844.5017439710539;853.4068822168564;854.3464249848871;854.4403415762686;854.7393045121236;631.6620607974711;631.9336469670665;633.6451587111186;634.4448607468465;635.428114696772;12967.22196668203;13041.021923355785;13092.738145237137;13094.279814610192;13100.60698179056;12559.246445213224;12708.237505749685;12815.231086134861;12863.807042894365;13093.934530327382;10148.543315550818;10149.340292881014;10211.846822297672;10290.43402612856;10478.266521343508;3605.405108157151;3701.68535674468;3704.5369328833895;3788.8484460621544;3797.6392242736897;47362.289565656545;47513.76243118797;47578.76210618959;47738.28392574114;47792.28311575329;8699.695510657097;8941.150590693873;9016.233620142362;9109.68116115946;9177.403468774508;17215.483535493957;17483.56291092733;17500.387486437914;17550.912245438692;17585;7368.631568421558;7534.666952751125;7631.1605723370385;7752.0697516298405;7776.377889768805;4120.835166593302;4142.79286035697;4159.563245859141;4169.56219596944;4206.369044643328;3018.5623084653043;3021.864016119236;3036.9240768980953;3050.054483110243;3055.0834749575038;564.6188822544766;569.8432930944024;571.7141429285357;574.1588572740955;596.8358701357162;539.8738973447145;547.5920439272687;629.2449061126666;665.3745479249586;692.6675195905892;8790.516521591246;8860.911390886138;8870.556472176366;8917.197452229331;9046.140616641409;524.4571868116481;531.1183435497134;542.6608369768894;543.2530270877544;583.4690431707127;4119.887630339791;4121.754592769452;4233.851815186454;4329.978350108229;4362.323839804835;54117.45882541203;55074.44925550773;55093.72453137708;55179.72410137924;55859;48930;48937.2659410102;49587.25619115716;49832;49898.25152622713;43796.56203437925;44315;44438;44485;44510.77744611321;8420.915790842013;8573.271271941954;8622.137786221328;8668.176523230282;8786.209241168326;32427.513587295736;32849.50725739163;33019.33961320712;33070.66929330772;33126.33747325088;39895.60104398919;42849.785751071046;43268;43830.34254486249;43894.56105438905;10285.9485702571;10495.790084198426;11178.608748693756;11213.71965700864;11716.882831171579;12175.269483830998;12658.683532911382;12743.10798244114;12798.296093714935;13117.868821311664;11245.550177992789;11662.650120496059;11829.881701183222;12005.699857503283;12375.814362784386;11358.829617555908;11817.822732658846;11880.702982425508;12107.273563586214;12363.258204507758;11641.708957276136;12122.212056216318;12162.817557736818;12254.080943929419;12369.93815030919;9335.85996210071;9368.531573421165;9433.528783050946;9597.857886646723;9666.371685840679;9102.635894564144;9160.816783664157;9518.809623807347;9551.808963820824;9891.653792117242 05:29:48 INFO - PROCESS | 15491 | __end_tp_report 05:29:48 INFO - PROCESS | 15491 | __start_cc_report 05:29:48 INFO - PROCESS | 15491 | _x_x_mozilla_cycle_collect,307 05:29:48 INFO - PROCESS | 15491 | __end_cc_report 05:29:48 INFO - PROCESS | 15491 | __startTimestamp1453296587996__endTimestamp 05:29:48 INFO - PROCESS | 15491 | 05:29:48 INFO - PROCESS | 15491 | ------- Summary: start ------- 05:29:48 INFO - PROCESS | 15491 | Number of tests: 6 05:29:48 INFO - PROCESS | 15491 | 05:29:48 INFO - PROCESS | 15491 | [#0] dojo.html Cycles:165 Average:5174.45 Median:5374.25 stddev:561.07 (10.4%) stddev-sans-first:538.33 05:29:48 INFO - PROCESS | 15491 | Values: 3085.6 3097.8 3118.2 3134.0 3159.2 5066.7 5105.5 5117.7 5144.6 5165.3 5124.5 5129.1 5169.9 5203.1 5225.8 4430.5 4697.8 4833.3 4834.7 4843.9 4749.8 4769.0 4807.2 4820.0 4821.2 4731.3 4731.4 4743.4 4821.1 4832.3 4750.5 4755.3 4767.8 4787.0 4809.1 4677.3 4747.0 4770.6 4778.1 4778.8 4946.4 4993.3 5004.7 5021.2 5050.5 5492.7 5513.1 5520.4 5551.7 5565.6 5473.2 5510.9 5552.0 5580.0 5642.6 5126.5 5258.9 5300.4 5305.4 5358.6 5632.9 5633.0 5639.5 5666.5 5690.5 5411.0 5461.5 5468.4 5481.6 5543.3 5547.9 5611.6 5614.4 5628.5 5673.1 5425.7 5440.9 5447.8 5451.9 5454.3 5457.2 5464.0 5465.8 5530.6 5577.8 4328.2 4371.7 4373.1 4401.0 4409.1 3881.1 3881.6 3891.5 3893.6 3943.9 5150.8 5163.0 5258.0 5304.8 5338.6 5554.2 5579.8 5601.1 5603.1 5661.9 5247.1 5256.2 5268.1 5272.4 5309.7 4674.2 4750.1 4764.7 4786.7 4802.8 5778.8 5815.3 5874.4 5876.0 5923.6 5535.8 5542.0 5546.2 5571.8 5574.5 5643.7 5739.7 5784.7 5786.3 5815.4 5495.7 5496.9 5503.6 5508.9 5565.2 5590.8 5607.7 5609.8 5615.7 5617.1 5463.4 5468.8 5469.1 5471.2 5475.9 5316.0 5436.2 5450.1 5464.8 5502.5 5336.6 5340.7 5341.4 5361.8 5374.2 5420.4 5436.9 5464.5 5475.7 5518.3 5287.8 5314.8 5375.9 5376.3 5377.6 05:29:48 INFO - PROCESS | 15491 | 05:29:48 INFO - PROCESS | 15491 | [#1] ext.html Cycles:180 Average:46507.85 Median:387135.00 stddev:81603.67 (21.1%) stddev-sans-first:81759.49 05:29:48 INFO - PROCESS | 15491 | Values: 503.3 531.4 543.6 568.2 570.0 39338.2 39573.8 39854.8 39871.6 40000.4 44219.6 44647.3 44850.0 45273.5 45358.5 8646.5 8779.7 8798.2 8819.2 8827.2 8558.2 8662.6 8679.6 8715.6 8717.9 8618.8 8743.3 8756.0 8761.8 8787.0 8576.7 8621.9 8677.5 8684.8 8724.2 8575.6 8678.5 8749.7 8753.8 8769.5 39299.6 40100.0 40291.4 40312.0 40433.8 2711.2 2757.4 2953.8 3222.1 3738.1 27122.1 27313.7 28614.9 28688.1 28838.9 3909.6 3943.4 3996.4 4045.5 4066.5 218930.0 220959.9 221349.0 221420.0 222259.0 42798.6 43107.0 43486.6 56658.0 57078.7 41229.4 41592.4 41613.8 41619.4 41777.0 13536.7 13593.5 13625.7 13671.9 13696.0 10682.1 10707.7 10739.4 10780.2 10797.7 14317.3 14334.8 14467.8 14505.3 14567.9 5737.6 5766.0 5825.8 5826.2 5916.1 948.5 961.4 1047.6 1061.7 1100.8 28373.3 29017.6 29065.0 29259.3 29399.0 1015.4 1047.7 1071.1 1086.8 1094.4 14504.4 14639.1 14685.6 14812.4 14851.9 383883.0 384964.0 385977.0 388293.0 389541.0 54334.7 54694.7 54876.0 54878.7 54939.0 1339.7 1352.0 1360.2 1362.2 1365.4 25618.5 27226.5 27379.5 27414.5 32264.0 50251.2 50736.5 50980.5 50987.0 51164.0 298232.0 298727.0 302507.0 302551.0 303183.0 41636.0 42952.1 44597.0 44616.0 44695.3 39548.4 40486.4 40610.2 40701.8 40809.6 33899.0 34467.5 34635.0 34725.3 34806.3 34554.7 34666.3 34741.0 35003.1 35199.6 35461.8 35617.8 35725.8 35746.3 36093.6 31747.4 32357.4 32398.4 32429.4 32572.0 24494.8 24547.3 24613.5 24978.8 25132.7 05:29:48 INFO - PROCESS | 15491 | 05:29:48 INFO - PROCESS | 15491 | [#2] jquery.html Cycles:180 Average:25709.37 Median:4980.22 stddev:79321.78 (1592.7%) stddev-sans-first:79521.44 05:29:48 INFO - PROCESS | 15491 | Values: 350.6 351.6 360.2 360.4 365.3 15615.8 16301.6 17079.3 17640.0 17846.7 15630.8 15653.4 15656.6 16329.1 16334.3 4780.7 4937.2 4938.9 4983.1 4989.6 4887.1 4915.1 4977.4 5276.1 5362.3 5339.6 5347.5 5414.8 5600.6 5624.5 5468.4 5582.0 5615.9 5925.0 6008.3 5347.3 5348.0 5349.8 5363.7 5366.3 16687.0 19187.0 19626.8 20460.4 20503.6 2028.7 2032.4 2091.9 2115.0 2119.4 9223.5 9310.8 9546.3 9560.7 12606.6 1646.6 1752.5 1759.8 1779.9 1875.9 56425.1 57536.4 57579.1 57738.4 58502.4 9965.5 10001.0 10161.7 10165.0 10274.4 12995.9 13148.5 13177.7 13209.6 13229.7 7215.8 7271.6 7313.2 7321.8 7413.5 6908.0 6937.3 6974.2 6994.1 6996.1 4359.0 4430.1 4438.6 4444.9 4465.3 1822.2 1830.3 1906.1 1911.9 1920.7 888.9 983.9 989.8 997.6 1010.6 16107.7 16148.9 16580.2 16713.7 16988.2 927.6 950.2 954.4 986.8 990.8 9428.3 9571.6 9583.7 9689.8 9831.1 474637.0 475352.0 476598.0 482684.0 515665.0 69844.7 71603.3 71804.0 73645.0 73915.0 1111.1 1114.5 1153.6 1165.9 1169.4 14206.1 14572.9 14687.3 14790.7 15036.5 30650.2 30860.7 31209.2 32173.7 32205.0 36735.4 36777.4 37090.8 37233.8 37609.4 6873.2 7023.4 7058.4 7184.9 7233.9 8515.7 10495.2 10557.6 10654.9 10838.9 7760.7 9494.4 9710.6 9769.9 9916.8 9027.7 9189.4 9618.9 9834.7 10153.4 8686.7 8843.4 9468.9 9868.2 9921.2 6811.4 6893.8 7118.2 7197.5 7219.0 8526.6 8912.3 9139.5 9408.8 9609.1 05:29:48 INFO - PROCESS | 15491 | 05:29:48 INFO - PROCESS | 15491 | [#3] mootools.html Cycles:180 Average:5497.18 Median:6415.52 stddev:2774.33 (43.2%) stddev-sans-first:2765.50 05:29:48 INFO - PROCESS | 15491 | Values: 1457.5 1464.5 1650.2 1792.1 1839.2 7726.0 7740.7 7865.2 7916.4 7937.0 7895.4 7931.4 8000.4 8011.6 8040.5 2312.6 2315.3 2316.6 2324.4 2330.4 2348.3 2351.7 2390.0 2391.3 2397.8 2199.9 2248.8 2256.7 2332.5 2333.8 2305.6 2329.7 2347.6 2355.9 2357.2 2374.4 2377.3 2382.8 2384.4 2385.3 7666.8 7669.5 7718.3 7723.1 7732.9 4766.5 4892.6 4899.2 4913.9 4937.2 3230.5 3265.6 3296.8 3297.9 3335.8 984.5 986.4 1129.4 1140.9 1166.9 10685.6 10755.7 10767.1 10783.1 10847.2 4179.8 4246.9 4289.8 4315.1 4331.3 8716.6 8846.6 8857.6 8858.9 8865.8 4846.3 4874.8 4880.4 4882.0 4886.9 4411.2 4426.7 4435.0 4466.2 4486.7 3546.8 3617.8 3618.0 3620.5 3659.0 1106.4 1119.2 1126.0 1134.3 1156.2 1338.5 1339.6 1369.5 1376.9 1381.1 7307.6 7361.5 7437.9 7438.5 7501.9 1120.4 1121.1 1121.9 1150.2 1157.9 5724.5 5765.9 5797.3 5831.2 5838.2 8820.0 8847.7 9076.5 9078.0 9110.6 8982.9 9075.5 9105.6 9114.1 9142.8 6959.9 7030.8 7103.4 7140.4 7193.0 7210.5 7237.1 7305.3 7325.7 7427.3 8204.8 8231.0 8387.0 8464.2 8499.3 8528.7 8599.6 8610.7 8649.8 8668.5 7200.1 7514.8 7549.5 7564.8 7597.0 7421.0 7486.1 7503.0 7541.3 7543.7 6445.8 6815.5 6998.9 7292.5 7295.9 6817.6 6870.3 6930.4 6970.8 7006.5 6922.2 6939.9 6985.5 6991.3 6999.0 6201.8 6410.5 6414.3 6416.8 6417.6 6497.0 6503.6 6510.2 6515.1 6668.7 05:29:48 INFO - PROCESS | 15491 | 05:29:48 INFO - PROCESS | 15491 | [#4] prototype.html Cycles:180 Average:5517.41 Median:6222.83 stddev:1649.18 (26.5%) stddev-sans-first:1607.05 05:29:48 INFO - PROCESS | 15491 | Values: 322.6 330.3 332.9 351.5 358.1 6190.6 6268.7 6289.1 6291.1 6399.7 6202.5 6238.4 6246.5 6254.6 6263.0 4740.9 4742.2 4779.6 4784.7 4787.1 4789.3 4804.7 4806.6 4807.7 4812.0 4682.4 4735.5 4745.0 4746.2 4755.9 4726.6 4731.6 4738.0 4738.8 4748.2 4108.9 4112.2 4113.2 4114.7 4116.4 5966.0 5976.6 5978.0 5982.9 5985.9 5399.9 5497.8 5501.6 5504.1 5509.5 6632.5 6634.0 6635.3 6642.7 6650.4 4525.7 4526.4 4530.7 4531.1 4540.6 6656.3 6826.4 6851.1 6878.9 6902.3 4662.1 4688.3 4688.9 4690.1 4694.5 4746.9 4773.5 4782.6 4790.1 4795.6 5453.7 5496.6 5512.0 5516.8 5520.8 6502.8 6613.9 6624.4 6625.8 6630.2 1665.5 1675.4 1721.6 1726.5 1726.9 1180.3 1183.5 1185.8 1187.1 1197.5 6200.5 6211.1 6218.5 6222.3 6223.4 6674.8 6683.5 6701.8 6731.4 6749.3 6058.0 6168.5 6170.5 6186.6 6205.8 3618.4 3646.7 3659.6 3663.6 3679.9 7003.2 7031.1 7038.4 7041.4 7089.4 6715.2 6875.0 6891.7 6902.0 6905.8 6979.5 7015.2 7020.4 7021.0 7041.5 6724.4 6738.2 6739.4 6751.9 6762.9 6494.1 6631.5 6639.0 6655.7 6704.9 6988.9 7019.0 7043.4 7058.4 7069.6 4787.1 4807.3 4827.3 4827.5 4831.2 6629.0 6654.7 6688.2 6735.6 6884.8 6668.9 6693.9 6720.3 6721.9 6727.9 6603.1 6627.0 6635.0 6636.7 6665.9 6423.4 6477.3 6533.3 6550.9 6559.9 6684.9 6702.4 6706.6 6709.7 6716.8 6550.7 6554.2 6560.1 6560.7 6568.8 05:29:48 INFO - PROCESS | 15491 | 05:29:48 INFO - PROCESS | 15491 | [#5] yui.html Cycles:180 Average:13508.39 Median:47438.03 stddev:15307.38 (32.3%) stddev-sans-first:15320.69 05:29:48 INFO - PROCESS | 15491 | Values: 826.6 827.3 828.9 836.1 837.2 13389.5 13406.3 13491.4 13495.3 13566.2 12922.6 12924.6 12996.8 13032.9 13063.5 660.7 670.4 801.8 831.2 833.9 821.0 824.2 826.9 829.6 830.3 852.4 853.1 857.4 859.6 863.8 844.5 853.4 854.3 854.4 854.7 631.7 631.9 633.6 634.4 635.4 12967.2 13041.0 13092.7 13094.3 13100.6 12559.2 12708.2 12815.2 12863.8 13093.9 10148.5 10149.3 10211.8 10290.4 10478.3 3605.4 3701.7 3704.5 3788.8 3797.6 47362.3 47513.8 47578.8 47738.3 47792.3 8699.7 8941.2 9016.2 9109.7 9177.4 17215.5 17483.6 17500.4 17550.9 17585.0 7368.6 7534.7 7631.2 7752.1 7776.4 4120.8 4142.8 4159.6 4169.6 4206.4 3018.6 3021.9 3036.9 3050.1 3055.1 564.6 569.8 571.7 574.2 596.8 539.9 547.6 629.2 665.4 692.7 8790.5 8860.9 8870.6 8917.2 9046.1 524.5 531.1 542.7 543.3 583.5 4119.9 4121.8 4233.9 4330.0 4362.3 54117.5 55074.4 55093.7 55179.7 55859.0 48930.0 48937.3 49587.3 49832.0 49898.3 43796.6 44315.0 44438.0 44485.0 44510.8 8420.9 8573.3 8622.1 8668.2 8786.2 32427.5 32849.5 33019.3 33070.7 33126.3 39895.6 42849.8 43268.0 43830.3 43894.6 10285.9 10495.8 11178.6 11213.7 11716.9 12175.3 12658.7 12743.1 12798.3 13117.9 11245.6 11662.7 11829.9 12005.7 12375.8 11358.8 11817.8 11880.7 12107.3 12363.3 11641.7 12122.2 12162.8 12254.1 12369.9 9335.9 9368.5 9433.5 9597.9 9666.4 9102.6 9160.8 9518.8 9551.8 9891.7 05:29:48 INFO - PROCESS | 15491 | -------- Summary: end -------- 05:29:48 INFO - PROCESS | 15491 | 05:29:48 INFO - TEST-INFO | 15491: exit 0 05:29:48 INFO - TEST-OK | dromaeo_css | took 1110940ms 05:29:48 INFO - TEST-START | kraken 05:29:48 INFO - operating with platform_type : linux_ 05:29:48 INFO - Initialising browser for kraken test... 05:29:48 INFO - TEST-INFO | started process 15735 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpL9Omuh/profile http://localhost:40141/getInfo.html) 05:29:52 INFO - PROCESS | 15735 | 05:29:52 INFO - PROCESS | 15735 | (process:15806): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:29:53 INFO - PROCESS | 15735 | __metrics Screen width/height:1600/1200 05:29:53 INFO - PROCESS | 15735 | colorDepth:24 05:29:53 INFO - PROCESS | 15735 | Browser inner width/height: 1024/697 05:29:53 INFO - PROCESS | 15735 | __metrics 05:29:53 INFO - PROCESS | 15735 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:29:53 INFO - PROCESS | 15735 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 05:29:54 INFO - TEST-INFO | 15735: exit 0 05:29:54 INFO - Browser initialized. 05:29:54 INFO - Running cycle 1/1 for kraken test... 05:29:54 INFO - TEST-INFO | started process 15855 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpL9Omuh/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:29:55 INFO - PROCESS | 15855 | -- checkerboarding starts below -- 05:29:55 INFO - PROCESS | 15855 | RENDERTRACE 0.041804 rect red 0 0 10 10 // viewport 05:29:55 INFO - PROCESS | 15855 | RENDERTRACE 60.5055 rect brown 0 0 10 10 // page 05:29:55 INFO - PROCESS | 15855 | RENDERTRACE 60.5282 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 05:29:55 INFO - PROCESS | 15855 | Checkerboarded for 1 frames (63.1579 ms), 100 peak, 1 severity. 05:29:55 INFO - PROCESS | 15855 | 05:29:55 INFO - PROCESS | 15855 | (process:15912): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:30:06 INFO - PROCESS | 15855 | RSS: Main: 149528576 05:30:06 INFO - PROCESS | 15855 | 05:30:08 INFO - PROCESS | 15855 | Cycle 1(1): loaded http://localhost:40141/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40141/tests/kraken/driver.html?testName=audio-beat-detection) 05:30:09 INFO - PROCESS | 15855 | RSS: Main: 150626304 05:30:09 INFO - PROCESS | 15855 | 05:30:12 INFO - PROCESS | 15855 | Cycle 1(1): loaded http://localhost:40141/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40141/tests/kraken/driver.html?testName=audio-dft) 05:30:12 INFO - PROCESS | 15855 | RSS: Main: 154603520 05:30:12 INFO - PROCESS | 15855 | 05:30:15 INFO - PROCESS | 15855 | Cycle 1(1): loaded http://localhost:40141/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40141/tests/kraken/driver.html?testName=audio-fft) 05:30:16 INFO - PROCESS | 15855 | RSS: Main: 146407424 05:30:16 INFO - PROCESS | 15855 | 05:30:18 INFO - PROCESS | 15855 | Cycle 1(1): loaded http://localhost:40141/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40141/tests/kraken/driver.html?testName=audio-oscillator) 05:30:19 INFO - PROCESS | 15855 | RSS: Main: 147693568 05:30:19 INFO - PROCESS | 15855 | 05:30:21 INFO - PROCESS | 15855 | Cycle 1(1): loaded http://localhost:40141/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40141/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:30:22 INFO - PROCESS | 15855 | RSS: Main: 147755008 05:30:22 INFO - PROCESS | 15855 | 05:30:24 INFO - PROCESS | 15855 | Cycle 1(1): loaded http://localhost:40141/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40141/tests/kraken/driver.html?testName=imaging-darkroom) 05:30:25 INFO - PROCESS | 15855 | RSS: Main: 148054016 05:30:25 INFO - PROCESS | 15855 | 05:30:28 INFO - PROCESS | 15855 | Cycle 1(1): loaded http://localhost:40141/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40141/tests/kraken/driver.html?testName=imaging-desaturate) 05:30:29 INFO - PROCESS | 15855 | RSS: Main: 148377600 05:30:29 INFO - PROCESS | 15855 | 05:30:32 INFO - PROCESS | 15855 | Cycle 1(1): loaded http://localhost:40141/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40141/tests/kraken/driver.html?testName=json-parse-financial) 05:30:32 INFO - PROCESS | 15855 | RSS: Main: 150315008 05:30:32 INFO - PROCESS | 15855 | 05:30:34 INFO - PROCESS | 15855 | Cycle 1(1): loaded http://localhost:40141/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40141/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:30:35 INFO - PROCESS | 15855 | RSS: Main: 149725184 05:30:35 INFO - PROCESS | 15855 | 05:30:36 INFO - PROCESS | 15855 | Cycle 1(1): loaded http://localhost:40141/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40141/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:30:37 INFO - PROCESS | 15855 | RSS: Main: 150716416 05:30:37 INFO - PROCESS | 15855 | 05:30:39 INFO - PROCESS | 15855 | Cycle 1(1): loaded http://localhost:40141/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40141/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:30:40 INFO - PROCESS | 15855 | RSS: Main: 150462464 05:30:40 INFO - PROCESS | 15855 | 05:30:42 INFO - PROCESS | 15855 | Cycle 1(1): loaded http://localhost:40141/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40141/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:30:43 INFO - PROCESS | 15855 | RSS: Main: 151146496 05:30:43 INFO - PROCESS | 15855 | 05:30:45 INFO - PROCESS | 15855 | Cycle 1(1): loaded http://localhost:40141/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40141/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:30:46 INFO - PROCESS | 15855 | RSS: Main: 152006656 05:30:46 INFO - PROCESS | 15855 | 05:30:48 INFO - PROCESS | 15855 | Cycle 1(1): loaded http://localhost:40141/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40141/tests/kraken/driver.html?testName=ai-astar) 05:30:48 INFO - PROCESS | 15855 | RSS: Main: 151126016 05:30:48 INFO - PROCESS | 15855 | 05:30:48 INFO - PROCESS | 15855 | __start_tp_report 05:30:48 INFO - PROCESS | 15855 | _x_x_mozilla_page_load 05:30:48 INFO - PROCESS | 15855 | _x_x_mozilla_page_load_details 05:30:48 INFO - PROCESS | 15855 | |i|pagename|runs| 05:30:48 INFO - PROCESS | 15855 | |0;ai-astar;114;106;112;112;111;123;112;112;110;113 05:30:48 INFO - PROCESS | 15855 | |1;audio-beat-detection;149;136;159;158;128;149;150;129;166;134 05:30:48 INFO - PROCESS | 15855 | |2;audio-dft;163;163;166;164;162;164;162;166;168;160 05:30:48 INFO - PROCESS | 15855 | |3;audio-fft;76;76;75;74;74;77;158;76;75;76 05:30:48 INFO - PROCESS | 15855 | |4;audio-oscillator;95;98;142;96;97;96;142;96;98;140 05:30:48 INFO - PROCESS | 15855 | |5;imaging-gaussian-blur;111;111;110;110;110;110;109;110;110;110 05:30:48 INFO - PROCESS | 15855 | |6;imaging-darkroom;147;146;147;147;146;148;146;147;146;148 05:30:48 INFO - PROCESS | 15855 | |7;imaging-desaturate;97;97;96;99;97;96;97;98;97;97 05:30:48 INFO - PROCESS | 15855 | |8;json-parse-financial;61;61;61;60;62;62;61;63;68;61 05:30:48 INFO - PROCESS | 15855 | |9;json-stringify-tinderbox;69;69;69;69;72;70;69;69;71;69 05:30:48 INFO - PROCESS | 15855 | |10;stanford-crypto-aes;91;83;84;84;85;82;82;83;83;81 05:30:48 INFO - PROCESS | 15855 | |11;stanford-crypto-ccm;118;117;127;126;117;121;117;124;122;120 05:30:48 INFO - PROCESS | 15855 | |12;stanford-crypto-pbkdf2;133;146;164;143;133;143;143;147;146;142 05:30:48 INFO - PROCESS | 15855 | |13;stanford-crypto-sha256-iterative;80;67;67;66;69;68;70;67;67;76 05:30:48 INFO - PROCESS | 15855 | __end_tp_report 05:30:48 INFO - PROCESS | 15855 | __start_cc_report 05:30:48 INFO - PROCESS | 15855 | _x_x_mozilla_cycle_collect,759 05:30:48 INFO - PROCESS | 15855 | __end_cc_report 05:30:48 INFO - PROCESS | 15855 | __startTimestamp1453296648380__endTimestamp 05:30:48 INFO - PROCESS | 15855 | 05:30:48 INFO - PROCESS | 15855 | ------- Summary: start ------- 05:30:48 INFO - PROCESS | 15855 | Number of tests: 14 05:30:48 INFO - PROCESS | 15855 | 05:30:48 INFO - PROCESS | 15855 | [#0] ai-astar Cycles:10 Average:112.50 Median:112.00 stddev:4.28 (3.8%) stddev-sans-first:4.50 05:30:48 INFO - PROCESS | 15855 | Values: 114.0 106.0 112.0 112.0 111.0 123.0 112.0 112.0 110.0 113.0 05:30:48 INFO - PROCESS | 15855 | 05:30:48 INFO - PROCESS | 15855 | [#1] audio-beat-detection Cycles:10 Average:145.80 Median:149.50 stddev:13.35 (8.9%) stddev-sans-first:14.11 05:30:48 INFO - PROCESS | 15855 | Values: 149.0 136.0 159.0 158.0 128.0 149.0 150.0 129.0 166.0 134.0 05:30:48 INFO - PROCESS | 15855 | 05:30:48 INFO - PROCESS | 15855 | [#2] audio-dft Cycles:10 Average:163.80 Median:164.00 stddev:2.35 (1.4%) stddev-sans-first:2.47 05:30:48 INFO - PROCESS | 15855 | Values: 163.0 163.0 166.0 164.0 162.0 164.0 162.0 166.0 168.0 160.0 05:30:48 INFO - PROCESS | 15855 | 05:30:48 INFO - PROCESS | 15855 | [#3] audio-fft Cycles:10 Average:83.70 Median:76.00 stddev:26.12 (34.4%) stddev-sans-first:27.56 05:30:48 INFO - PROCESS | 15855 | Values: 76.0 76.0 75.0 74.0 74.0 77.0 158.0 76.0 75.0 76.0 05:30:48 INFO - PROCESS | 15855 | 05:30:48 INFO - PROCESS | 15855 | [#4] audio-oscillator Cycles:10 Average:110.00 Median:96.00 stddev:21.65 (22.6%) stddev-sans-first:22.27 05:30:48 INFO - PROCESS | 15855 | Values: 95.0 98.0 142.0 96.0 97.0 96.0 142.0 96.0 98.0 140.0 05:30:48 INFO - PROCESS | 15855 | 05:30:48 INFO - PROCESS | 15855 | [#5] imaging-gaussian-blur Cycles:10 Average:110.10 Median:110.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 05:30:48 INFO - PROCESS | 15855 | Values: 111.0 111.0 110.0 110.0 110.0 110.0 109.0 110.0 110.0 110.0 05:30:48 INFO - PROCESS | 15855 | 05:30:48 INFO - PROCESS | 15855 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 05:30:48 INFO - PROCESS | 15855 | Values: 147.0 146.0 147.0 147.0 146.0 148.0 146.0 147.0 146.0 148.0 05:30:48 INFO - PROCESS | 15855 | 05:30:48 INFO - PROCESS | 15855 | [#7] imaging-desaturate Cycles:10 Average:97.10 Median:97.00 stddev:0.88 (0.9%) stddev-sans-first:0.93 05:30:48 INFO - PROCESS | 15855 | Values: 97.0 97.0 96.0 99.0 97.0 96.0 97.0 98.0 97.0 97.0 05:30:48 INFO - PROCESS | 15855 | 05:30:48 INFO - PROCESS | 15855 | [#8] json-parse-financial Cycles:10 Average:62.00 Median:61.50 stddev:2.26 (3.7%) stddev-sans-first:2.37 05:30:48 INFO - PROCESS | 15855 | Values: 61.0 61.0 61.0 60.0 62.0 62.0 61.0 63.0 68.0 61.0 05:30:48 INFO - PROCESS | 15855 | 05:30:48 INFO - PROCESS | 15855 | [#9] json-stringify-tinderbox Cycles:10 Average:69.60 Median:69.00 stddev:1.07 (1.6%) stddev-sans-first:1.12 05:30:48 INFO - PROCESS | 15855 | Values: 69.0 69.0 69.0 69.0 72.0 70.0 69.0 69.0 71.0 69.0 05:30:48 INFO - PROCESS | 15855 | 05:30:48 INFO - PROCESS | 15855 | [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:83.50 stddev:2.78 (3.3%) stddev-sans-first:1.22 05:30:48 INFO - PROCESS | 15855 | Values: 91.0 83.0 84.0 84.0 85.0 82.0 82.0 83.0 83.0 81.0 05:30:48 INFO - PROCESS | 15855 | 05:30:48 INFO - PROCESS | 15855 | [#11] stanford-crypto-ccm Cycles:10 Average:120.90 Median:121.50 stddev:3.78 (3.1%) stddev-sans-first:3.87 05:30:48 INFO - PROCESS | 15855 | Values: 118.0 117.0 127.0 126.0 117.0 121.0 117.0 124.0 122.0 120.0 05:30:48 INFO - PROCESS | 15855 | 05:30:48 INFO - PROCESS | 15855 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.00 Median:144.50 stddev:8.60 (6.0%) stddev-sans-first:8.15 05:30:48 INFO - PROCESS | 15855 | Values: 133.0 146.0 164.0 143.0 133.0 143.0 143.0 147.0 146.0 142.0 05:30:48 INFO - PROCESS | 15855 | 05:30:48 INFO - PROCESS | 15855 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.70 Median:68.50 stddev:4.62 (6.7%) stddev-sans-first:3.05 05:30:48 INFO - PROCESS | 15855 | Values: 80.0 67.0 67.0 66.0 69.0 68.0 70.0 67.0 67.0 76.0 05:30:48 INFO - PROCESS | 15855 | -------- Summary: end -------- 05:30:48 INFO - PROCESS | 15855 | 05:30:49 INFO - TEST-INFO | 15855: exit 0 05:30:49 INFO - TEST-OK | kraken | took 60740ms 05:30:49 INFO - TEST-START | v8_7 05:30:49 INFO - operating with platform_type : linux_ 05:30:49 INFO - Initialising browser for v8_7 test... 05:30:49 INFO - TEST-INFO | started process 16140 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp5dDIZE/profile http://localhost:40141/getInfo.html) 05:30:53 INFO - PROCESS | 16140 | 05:30:53 INFO - PROCESS | 16140 | (process:16216): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:30:54 INFO - PROCESS | 16140 | __metrics Screen width/height:1600/1200 05:30:54 INFO - PROCESS | 16140 | colorDepth:24 05:30:54 INFO - PROCESS | 16140 | Browser inner width/height: 1024/697 05:30:54 INFO - PROCESS | 16140 | __metrics 05:30:54 INFO - PROCESS | 16140 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:30:55 INFO - TEST-INFO | 16140: exit 0 05:30:55 INFO - Browser initialized. 05:30:55 INFO - Running cycle 1/1 for v8_7 test... 05:30:55 INFO - TEST-INFO | started process 16266 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp5dDIZE/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:30:56 INFO - PROCESS | 16266 | -- checkerboarding starts below -- 05:30:56 INFO - PROCESS | 16266 | RENDERTRACE 0.070287 rect red 0 0 10 10 // viewport 05:30:56 INFO - PROCESS | 16266 | RENDERTRACE 35.4001 rect brown 0 0 10 10 // page 05:30:56 INFO - PROCESS | 16266 | RENDERTRACE 35.4257 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 05:30:56 INFO - PROCESS | 16266 | Checkerboarded for 1 frames (37.4761 ms), 100 peak, 2 severity. 05:30:56 INFO - PROCESS | 16266 | 05:30:56 INFO - PROCESS | 16266 | (process:16326): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:31:07 INFO - PROCESS | 16266 | RSS: Main: 150196224 05:31:07 INFO - PROCESS | 16266 | 05:31:29 INFO - PROCESS | 16266 | Cycle 1(1): loaded http://localhost:40141/tests/v8_7/run.html (next: http://localhost:40141/tests/v8_7/run.html) 05:31:30 INFO - PROCESS | 16266 | RSS: Main: 145231872 05:31:30 INFO - PROCESS | 16266 | 05:31:30 INFO - PROCESS | 16266 | __start_tp_report 05:31:30 INFO - PROCESS | 16266 | _x_x_mozilla_page_load 05:31:30 INFO - PROCESS | 16266 | _x_x_mozilla_page_load_details 05:31:30 INFO - PROCESS | 16266 | |i|pagename|runs| 05:31:30 INFO - PROCESS | 16266 | |0;Richards;167.897918065816 05:31:30 INFO - PROCESS | 16266 | |1;DeltaBlue;187.89928598271325 05:31:30 INFO - PROCESS | 16266 | |2;Encrypt;278.9400278940028 05:31:30 INFO - PROCESS | 16266 | |3;Decrypt;5208.333333333333 05:31:30 INFO - PROCESS | 16266 | |4;RayTrace;1063.8297872340424 05:31:30 INFO - PROCESS | 16266 | |5;Earley;715.8196134574088 05:31:30 INFO - PROCESS | 16266 | |6;Boyer;12432.098765432098 05:31:30 INFO - PROCESS | 16266 | |7;RegExp;40720 05:31:30 INFO - PROCESS | 16266 | |8;Splay;635.3836398224477 05:31:30 INFO - PROCESS | 16266 | |9;NavierStokes;4845.410628019324 05:31:30 INFO - PROCESS | 16266 | __end_tp_report 05:31:30 INFO - PROCESS | 16266 | __startTimestamp1453296690060__endTimestamp 05:31:30 INFO - PROCESS | 16266 | 05:31:30 INFO - PROCESS | 16266 | ------- Summary: start ------- 05:31:30 INFO - PROCESS | 16266 | Number of tests: 10 05:31:30 INFO - PROCESS | 16266 | 05:31:30 INFO - PROCESS | 16266 | [#0] Richards Cycles:1 Average:167.90 Median:167.90 stddev:0.00 (0.0%) 05:31:30 INFO - PROCESS | 16266 | Values: 167.9 05:31:30 INFO - PROCESS | 16266 | 05:31:30 INFO - PROCESS | 16266 | [#1] DeltaBlue Cycles:1 Average:187.90 Median:187.90 stddev:0.00 (0.0%) 05:31:30 INFO - PROCESS | 16266 | Values: 187.9 05:31:30 INFO - PROCESS | 16266 | 05:31:30 INFO - PROCESS | 16266 | [#2] Encrypt Cycles:1 Average:278.94 Median:278.94 stddev:0.00 (0.0%) 05:31:30 INFO - PROCESS | 16266 | Values: 278.9 05:31:30 INFO - PROCESS | 16266 | 05:31:30 INFO - PROCESS | 16266 | [#3] Decrypt Cycles:1 Average:5208.33 Median:5208.33 stddev:0.00 (0.0%) 05:31:30 INFO - PROCESS | 16266 | Values: 5208.3 05:31:30 INFO - PROCESS | 16266 | 05:31:30 INFO - PROCESS | 16266 | [#4] RayTrace Cycles:1 Average:1063.83 Median:1063.83 stddev:0.00 (0.0%) 05:31:30 INFO - PROCESS | 16266 | Values: 1063.8 05:31:30 INFO - PROCESS | 16266 | 05:31:30 INFO - PROCESS | 16266 | [#5] Earley Cycles:1 Average:715.82 Median:715.82 stddev:0.00 (0.0%) 05:31:30 INFO - PROCESS | 16266 | Values: 715.8 05:31:30 INFO - PROCESS | 16266 | 05:31:30 INFO - PROCESS | 16266 | [#6] Boyer Cycles:1 Average:12432.10 Median:12432.10 stddev:0.00 (0.0%) 05:31:30 INFO - PROCESS | 16266 | Values: 12432.1 05:31:30 INFO - PROCESS | 16266 | 05:31:30 INFO - PROCESS | 16266 | [#7] RegExp Cycles:1 Average:40720.00 Median:40720.00 stddev:0.00 (0.0%) 05:31:30 INFO - PROCESS | 16266 | Values: 40720.0 05:31:30 INFO - PROCESS | 16266 | 05:31:30 INFO - PROCESS | 16266 | [#8] Splay Cycles:1 Average:635.38 Median:635.38 stddev:0.00 (0.0%) 05:31:30 INFO - PROCESS | 16266 | Values: 635.4 05:31:30 INFO - PROCESS | 16266 | 05:31:30 INFO - PROCESS | 16266 | [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 05:31:30 INFO - PROCESS | 16266 | Values: 4845.4 05:31:30 INFO - PROCESS | 16266 | -------- Summary: end -------- 05:31:30 INFO - PROCESS | 16266 | 05:31:30 INFO - TEST-INFO | 16266: exit 0 05:31:31 INFO - TEST-OK | v8_7 | took 41638ms 05:31:31 INFO - SUITE-END | took 1213s 05:31:31 INFO - Completed test suite (00:20:13) 05:31:31 INFO - Working with test: dromaeo_css 05:31:31 INFO - Generating results file: dromaeo_css 05:31:31 INFO - Working with test: kraken 05:31:31 INFO - Generating results file: kraken 05:31:31 INFO - javascript benchmark 05:31:31 INFO - Working with test: v8_7 05:31:31 INFO - Generating results file: v8_7 05:31:31 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:31:31 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 05:31:31 INFO - process_Request line: dromaeo_css 6867.93 graph.html#tests=[[72,64,43]] 05:31:31 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:31:31 INFO - process_Request line: kraken 1519.80 graph.html#tests=[[232,64,43]] 05:31:31 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:31:31 INFO - process_Request line: v8_7 20255.37 graph.html#tests=[[230,64,43]] 05:31:31 INFO - RETURN: dromaeo_css: 6867.93 05:31:31 INFO - RETURN: kraken: 1519.80 05:31:31 INFO - RETURN: v8_7: 20255.37 05:31:31 INFO - javascript benchmark 05:31:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3085.5834462347575, 3097.7831551791373, 3118.2048577612704, 3134.0, 3159.194405426616, 5066.721330326831, 5105.489451054893, 5117.718525481102, 5144.588432925367, 5165.30268413764, 5124.487551244873, 5129.076766182095, 5169.870753231171, 5203.063448579254, 5225.843224703255, 4430.5126436092005, 4697.835575754849, 4833.29917162013, 4834.734089625069, 4843.854684359475, 4749.810007599692, 4769.0, 4807.206810876219, 4820.0, 4821.180399332122, 4731.33761273422, 4731.36126622905, 4743.35964644772, 4821.132196204681, 4832.275158726202, 4750.477447480775, 4755.310479980383, 4767.76161191939, 4787.018661174451, 4809.062232864593, 4677.251639737659, 4746.952530474686, 4770.570648641639, 4778.068276686047, 4778.761061946923, 4946.40643122824, 4993.300937868701, 5004.724740139291, 5021.246812978083, 5050.4697006814495, 5492.725363731797, 5513.09034009388, 5520.365158006841, 5551.694656793875, 5565.6104072714925, 5473.233747275384, 5510.889782204374, 5551.9722401388135, 5579.972100139514, 5642.576806739511, 5126.487351264881, 5258.92111618326, 5300.3639563252655, 5305.44292849253, 5358.624896257264, 5632.85917852057, 5633.0, 5639.464250896158, 5666.490015898589, 5690.5447564194765, 5410.97294513525, 5461.481159289861, 5468.37113731918, 5481.616286859961, 5543.334799824047, 5547.8890422192135, 5611.6071874969175, 5614.354349249888, 5628.465295796893, 5673.120666296731, 5425.728713564385, 5440.863978400572, 5447.754851031713, 5451.863703407367, 5454.290942177571, 5457.2359869618285, 5463.972680136653, 5465.754041068161, 5530.640508366943, 5577.776888924479, 4328.242557552416, 4371.737695738266, 4373.059792144704, 4400.977995110004, 4409.096135292258, 3881.146147847469, 3881.573026967031, 3891.5330160380936, 3893.6301051400073, 3943.881683549498, 5150.819721309811, 5163.044836705221, 5258.0, 5304.761285742151, 5338.626296159309, 5554.166874968787, 5579.776808927679, 5601.131824567198, 5603.075492543685, 5661.915071273934, 5247.10799164143, 5256.159014557652, 5268.104422248227, 5272.420033796279, 5309.681419114788, 4674.158651442773, 4750.07373562152, 4764.6664733469015, 4786.712797232108, 4802.783874725646, 5778.826635200867, 5815.302163740378, 5874.383189765013, 5876.0, 5923.6149650273455, 5535.778568857281, 5541.972290138524, 5546.195801608825, 5571.777128914798, 5574.498295153456, 5643.661380317194, 5739.684317362585, 5784.7107644618445, 5786.30564332266, 5815.41845815415, 5495.725213739377, 5496.917546236729, 5503.642263252876, 5508.889822203613, 5565.16522521625, 5590.8043218487155, 5607.663540187602, 5609.80365687199, 5615.7192140392, 5617.073182924772, 5463.426340234377, 5468.781248750005, 5469.07025805606, 5471.23402723627, 5475.945240547543, 5315.973420132875, 5436.184572314026, 5450.05602768664, 5464.754086066216, 5502.532284755841, 5336.573074153981, 5340.679559226459, 5341.439148889466, 5361.839144825662, 5374.247605335335, 5420.430854760351, 5436.8640783979135, 5464.453554644663, 5475.72621368922, 5518.2826232589505, 5287.788488460418, 5314.760835762478, 5375.865603359791, 5376.301080859464, 5377.569794416359], "unit": "score", "name": "dojo.html", "value": 5138.927334245221}, {"lowerIsBetter": false, "replicates": [503.3255437713463, 531.3862488825407, 543.6058857328435, 568.1591244957463, 569.985750356241, 39338.213235735304, 39573.80213098931, 39854.80072599633, 39871.601283987155, 40000.39999400008, 44219.557804421944, 44647.33029004568, 44850.0, 45273.54726452735, 45358.54641453584, 8646.481211127353, 8779.736607901774, 8798.164174403422, 8819.162179592928, 8827.161419665154, 8558.186972237658, 8662.566871656423, 8679.566021698922, 8715.607797649121, 8717.910261217348, 8618.78453038676, 8743.300535957109, 8756.03683594804, 8761.780955476132, 8787.0334263231, 8576.742697719048, 8621.913780862174, 8677.522736249504, 8684.782880427976, 8724.1712037357, 8575.614097365633, 8678.481265778526, 8749.650013999433, 8753.7811554711, 8769.517676527788, 39299.60700392988, 40100.0, 40291.395629065584, 40312.0, 40433.797831010655, 2711.240852561286, 2757.420941602266, 2953.8080024798533, 3222.146131275214, 3738.140227747606, 27122.050728224614, 27313.726862731517, 28614.856925715445, 28688.13935581936, 28838.855805721047, 3909.6285852843935, 3943.4479172915526, 3996.3805610130476, 4045.4740883685226, 4066.5323487798987, 218930.0, 220959.89520052457, 221349.0, 221420.0, 222259.0, 42798.57201427946, 43107.0, 43486.565134348886, 56658.0, 57078.7146064267, 41229.38155927663, 41592.37611435831, 41613.79193104015, 41619.37570936439, 41777.0, 13536.661583460493, 13593.456261749618, 13625.659358516117, 13671.931640341734, 13696.0, 10682.145428365711, 10707.678769636768, 10739.409332486632, 10780.245382823126, 10797.676069717922, 14317.284135793168, 14334.784978225334, 14467.78298325526, 14505.274736263145, 14567.854321456862, 5737.5983681141915, 5766.0, 5825.825225243249, 5826.1552074948895, 5916.112583112482, 948.4830767231875, 961.4423634292094, 1047.5966752800075, 1061.686802393296, 1100.763335882789, 28373.290667733472, 29017.56473652897, 29065.0, 29259.268518287212, 29399.0, 1015.3907655406697, 1047.6804574604819, 1071.127872740039, 1086.7935092332432, 1094.414488248783, 14504.419823206954, 14639.121652700873, 14685.559433216808, 14812.407503699947, 14851.851481485046, 383883.0, 384964.0, 385977.0, 388293.0, 389541.0, 54334.72832635811, 54694.72652636791, 54876.0, 54878.725606372514, 54939.0, 1339.6583871112805, 1352.0400515633814, 1360.1634994478325, 1362.203111179951, 1365.3924003818404, 25618.487630247662, 27226.45547089087, 27379.452410952068, 27414.451710966066, 32264.0, 50251.24623130729, 50736.49263507318, 50980.490195097576, 50987.0, 51164.0, 298232.0, 298727.0, 302507.0, 302551.0, 303183.0, 41636.0, 42952.134307912434, 44597.0, 44616.0, 44695.329570057125, 39548.40677389899, 40486.392704108875, 40610.1877962445, 40701.796491017354, 40809.59190408058, 33899.0, 34467.4829877547, 34635.0, 34725.30549389048, 34806.303873921875, 34554.65445345514, 34666.306673866886, 34741.0, 35003.124921877155, 35199.64800351964, 35461.82269088638, 35617.82191089028, 35725.821370892976, 35746.28507429785, 36093.63906361008, 31747.36505269928, 32357.35285294328, 32398.35203295968, 32429.35141297208, 32572.0, 24494.75505244996, 24547.263582092564, 24613.507729844943, 24978.75021249837, 25132.74867251304], "unit": "score", "name": "ext.html", "value": 17905.18443842106}, {"lowerIsBetter": false, "replicates": [350.64584769382924, 351.595664985267, 360.1769955651337, 360.41792505104246, 365.34785408046645, 15615.84384156158, 16301.592460188487, 17079.316827326922, 17640.0, 17846.732299015493, 15630.843691563081, 15653.373865045385, 15656.608584785386, 16329.101899395528, 16334.34662613494, 4780.737059461728, 4937.160682683934, 4938.901221975559, 4983.078130545842, 4989.57588604969, 4887.1447496688115, 4915.115279249751, 4977.3529441172595, 5276.076686579852, 5362.329708786402, 5339.5728341732765, 5347.491988261128, 5414.7834086636485, 5600.635958662694, 5624.465675760816, 5468.425815289397, 5582.0, 5615.943840561583, 5924.97037514814, 6008.3390827009, 5347.278117454132, 5348.0, 5349.839504814861, 5363.651362661414, 5366.302380690485, 16687.0, 19187.0, 19626.803731962784, 20460.38618841437, 20503.589928201352, 2028.6754119340835, 2032.4106009257298, 2091.884946327951, 2114.98942505288, 2119.4171602809197, 9223.53882305882, 9310.767230819216, 9546.284028697806, 9560.665376711851, 12606.621801345975, 1646.6212771062724, 1752.50053734685, 1759.7976232733145, 1779.946601601954, 1875.8968256745873, 56425.11595431633, 57536.42463575352, 57579.136312955336, 57738.42261577372, 58502.41497585012, 9965.451900145561, 10001.0, 10161.695149145537, 10165.0, 10274.383536987805, 12995.870041299655, 13148.539801106916, 13177.693903566838, 13209.603711888658, 13229.73540529184, 7215.783526494213, 7271.63641817907, 7313.195548489662, 7321.816954576072, 7413.4810563261135, 6907.963805429225, 6937.271586483447, 6974.163100427981, 6994.125734283215, 6996.090508233999, 4358.978205108954, 4430.091831174602, 4438.644908407319, 4444.888877778017, 4465.263231566755, 1822.1800189914327, 1830.2678928428736, 1906.1422359938083, 1911.9330823421114, 1920.6542822291842, 888.9466632002101, 983.8622592837008, 989.7773001074701, 997.5560875410517, 1010.5957616953131, 16107.677846443006, 16148.919255403884, 16580.17099145062, 16713.665726685398, 16988.235529400958, 927.5686805635412, 950.1923365139576, 954.4416516337881, 986.7681094942683, 990.8018396320765, 9428.292878034037, 9571.569279382444, 9583.664571739955, 9689.757756056155, 9831.066048725359, 474637.0, 475352.0, 476598.0, 482684.0, 515665.0, 69844.6507767458, 71603.28396715966, 71804.0, 73645.0, 73915.0, 1111.1000089927186, 1114.4873358255131, 1153.6020073074776, 1165.8659254185877, 1169.351010189336, 14206.147631142165, 14572.927135364256, 14687.339069741674, 14790.704185916436, 15036.473723419627, 30650.233744156576, 30860.69139308668, 31209.219769505944, 32173.67826321707, 32205.033848984567, 36735.448968264966, 36777.448338274415, 37090.814545927096, 37233.81383093176, 37609.43585846269, 6873.175218973755, 7023.384621536973, 7058.400035996998, 7184.8922266165, 7233.855322893407, 8515.74452766418, 10495.160387168855, 10557.63048293306, 10654.8934510657, 10838.945805270923, 7760.6895724172655, 9494.382865113745, 9710.563024664048, 9769.902300976899, 9916.75208119774, 9027.684031058881, 9189.402688825205, 9618.903810961801, 9834.655787047419, 10153.441560713936, 8686.706253090108, 8843.425177363451, 9468.905310947079, 9868.210543156387, 9921.206303495848, 6811.421029212573, 6893.827654308682, 7118.181409138016, 7197.46019048563, 7219.0, 8526.616302266537, 8912.287017038492, 9139.543022848964, 9408.764780880532, 9609.135177833748], "unit": "score", "name": "jquery.html", "value": 8027.959390673671}, {"lowerIsBetter": false, "replicates": [1457.4898785425103, 1464.4654701034126, 1650.183159336128, 1792.1308165539704, 1839.181564203928, 7725.9613701931485, 7740.72907448238, 7865.174156713534, 7916.366690664748, 7937.047554293478, 7895.447318687694, 7931.36549076074, 8000.359971202304, 8011.63947622357, 8040.477368971013, 2312.583734927712, 2315.2591170825344, 2316.6293393057113, 2324.418895276181, 2330.359151233416, 2348.295511346598, 2351.6825228594093, 2389.9880500597474, 2391.3184742348435, 2397.832151749378, 2199.9340019799433, 2248.775122487746, 2256.7291924969027, 2332.463533387322, 2333.778291062355, 2305.596520608895, 2329.7320808107115, 2347.612643913752, 2355.9057637694473, 2357.2456813819585, 2374.3945293950105, 2377.3105799318178, 2382.7617238276207, 2384.356223819559, 2385.2844146755906, 7666.769996900046, 7669.539827610305, 7718.305352518244, 7723.0732312122345, 7732.884006739903, 4766.523347665206, 4892.584130348924, 4899.216125419915, 4913.852584422473, 4937.1606826839525, 3230.547723318737, 3265.6081270247723, 3296.76922615417, 3297.917552061194, 3335.7831740936763, 984.547108330169, 986.3588667366198, 1129.4070612928197, 1140.9372484513349, 1166.9474873630706, 10685.572577096907, 10755.677329680122, 10767.084797792275, 10783.08343790771, 10847.186461015377, 4179.832806687759, 4246.893827654333, 4289.849855255114, 4315.115401342718, 4331.263685173528, 8716.564171791386, 8846.646134154691, 8857.557122143997, 8858.86711699325, 8865.778355541162, 4846.273059041101, 4874.8050077997195, 4880.414350277918, 4881.975590122027, 4886.877828054327, 4411.20598292304, 4426.690131690815, 4435.046465010038, 4466.196084704784, 4486.7083639563325, 3546.769459985093, 3617.764845285048, 3617.963820361815, 3620.5474315710535, 3659.0486473517076, 1106.446776611694, 1119.216548416112, 1125.983110253347, 1134.2854001978865, 1156.19066653343, 1338.5315139701222, 1339.5713371721151, 1369.5343583181766, 1376.9449222031008, 1381.1436909116412, 7307.634618269171, 7361.521501102411, 7437.85124297511, 7438.479306448497, 7501.887471687929, 1120.3781901045, 1121.1423261205184, 1121.8653761548503, 1150.2350936627217, 1157.8784227656142, 5724.484796368347, 5765.88468230633, 5797.304323481209, 5831.212786273799, 5838.241028666331, 8819.955900220459, 8847.69033083839, 9076.500792456478, 9078.046805085503, 9110.59002344896, 8982.910170898338, 9075.500847453453, 9105.635774569075, 9114.13415725505, 9142.81714365709, 6959.930400696029, 7030.753923612649, 7103.396211322096, 7140.393066589294, 7192.964035179686, 7210.531315464478, 7237.095363079615, 7305.305995930378, 7325.743598974011, 7427.331540161412, 8204.753857384288, 8231.0, 8386.993560772746, 8464.195901389357, 8499.320054395757, 8528.701495447629, 8599.570021499025, 8610.741677749678, 8649.789029535745, 8668.523231222343, 7200.099987501562, 7514.774556763306, 7549.547027178387, 7564.810879728051, 7596.96201519011, 7421.0, 7486.101667799899, 7502.962485187539, 7541.283578060075, 7543.698252069856, 6445.838854028687, 6815.488838337045, 6998.860022799618, 7292.486304318913, 7295.927040729524, 6817.5909445433435, 6870.3473170048765, 6930.445564354739, 6970.79087627372, 7006.509544331848, 6922.169339679271, 6939.930600693929, 6985.476089293425, 6991.300869912968, 6999.020137180697, 6201.844953876189, 6410.487161027013, 6414.262359828679, 6416.7754128605275, 6417.582857114273, 6496.967515162394, 6503.6097834130105, 6510.21877374718, 6515.0553169791065, 6668.733250669919], "unit": "score", "name": "mootools.html", "value": 4563.840547405573}, {"lowerIsBetter": false, "replicates": [322.5919212196572, 330.33272788966286, 332.9300846822167, 351.5271959214855, 358.06723485320725, 6190.597611155272, 6268.717907694153, 6289.119523266746, 6291.0563415487695, 6399.712012959416, 6202.534809889254, 6238.4385405313515, 6246.469050130733, 6254.593451425654, 6263.0, 4740.90518189636, 4742.241241401376, 4779.64152688548, 4784.66507344486, 4787.0904528139545, 4789.3294938708605, 4804.711717296974, 4806.615470762348, 4807.711537307755, 4812.037592481518, 4682.41469816273, 4735.455422626407, 4744.97627511862, 4746.1931471649905, 4755.9286610700865, 4726.645501587394, 4731.597814185781, 4737.976310118462, 4738.810447582093, 4748.169070412664, 4108.856190033334, 4112.198121366335, 4113.1568028554375, 4114.7119701620895, 4116.444280022189, 5966.0, 5976.611520251213, 5977.98374276374, 5982.880342393171, 5985.9401405986255, 5399.919001214985, 5497.8075767347955, 5501.642393244466, 5504.146857237135, 5509.504144626962, 6632.535722499427, 6634.004899265101, 6635.336466353374, 6642.701078451481, 6650.434713049397, 4525.660575456854, 4526.411566496367, 4530.682852200347, 4531.139083574143, 4540.636749060067, 6656.267810540837, 6826.351496607815, 6851.109355783766, 6878.931210687929, 6902.344277293649, 4662.090892275974, 4688.2733176357715, 4688.906221875612, 4690.061987602493, 4694.530546945278, 4746.881327966759, 4773.498782627774, 4782.6173906088125, 4790.113828941657, 4795.568398844121, 5453.727313634303, 5496.560275177976, 5512.0, 5516.834494965157, 5520.779168833282, 6502.837429064311, 6613.900791488131, 6624.403803657694, 6625.7680981166395, 6630.237522684856, 1665.4753752567901, 1675.4136052381812, 1721.5610019445212, 1726.4993151986034, 1726.913654317279, 1180.2859270141612, 1183.5088438298183, 1185.8458400407892, 1187.0681515010847, 1197.5449329254827, 6200.534959878028, 6211.068339749074, 6218.502519798405, 6222.253329600477, 6223.408776166257, 6674.83312917181, 6683.465322774166, 6701.765438209737, 6731.427828634523, 6749.257581666013, 6058.0, 6168.537359698041, 6170.475509581735, 6186.628802271788, 6205.844853878689, 3618.3848745713294, 3646.6535679110443, 3659.5608526976935, 3663.6336366363153, 3679.8712045078296, 7003.194632617212, 7031.050808140938, 7038.401735852408, 7041.436685065182, 7089.361957423856, 6715.160604924385, 6874.9656251718425, 6891.724331026803, 6902.0, 6905.827354316082, 6979.546329488567, 7015.193252775894, 7020.403265722369, 7020.964895175492, 7041.507094503438, 6724.394804467622, 6738.191417029791, 6739.359760822714, 6751.898721519279, 6762.8647427052165, 6494.058361537645, 6631.469482441489, 6638.966805165944, 6655.700493477902, 6704.932950670431, 6988.860222795617, 7018.964905175441, 7043.436525078084, 7058.400035996792, 7069.646517674199, 4787.090452814094, 4807.278908163804, 4827.324174615486, 4827.493113223201, 4831.202851529459, 6629.0, 6654.700538475877, 6688.197416310074, 6735.595864248161, 6884.793456196322, 6668.933310667026, 6693.933060669331, 6720.32796720324, 6721.899171512529, 6727.93272067273, 6603.075569420381, 6627.0, 6635.037919501742, 6636.701348439428, 6665.933340666531, 6423.389777971085, 6477.255115661759, 6533.346665333429, 6550.901736473861, 6559.934400655932, 6684.866302674017, 6702.430293424918, 6706.5640733352175, 6709.698063587248, 6716.83207919806, 6550.705218265094, 6554.246261679968, 6560.114384558024, 6560.704768285344, 6568.770093046721], "unit": "score", "name": "prototype.html", "value": 4982.319423589514}, {"lowerIsBetter": false, "replicates": [826.5536610230475, 827.3257295304327, 828.908820029797, 836.0844874862024, 837.2172019162083, 13389.464421423156, 13406.329683515822, 13491.39288732007, 13495.325233738298, 13566.186028838276, 12922.612321630366, 12924.612261632143, 12996.805047924288, 13032.869671303284, 13063.542776002818, 660.712590023339, 670.4368330602293, 801.7714951238898, 831.1812864328631, 833.8832563441123, 820.9876851847197, 824.2169938558363, 826.8553003224412, 829.5810615639124, 830.2901019628222, 852.4118358332762, 853.117023880284, 857.4212406625534, 859.5616235719765, 863.753830158405, 844.5017439710539, 853.4068822168564, 854.3464249848871, 854.4403415762686, 854.7393045121236, 631.6620607974711, 631.9336469670665, 633.6451587111186, 634.4448607468465, 635.428114696772, 12967.22196668203, 13041.021923355785, 13092.738145237137, 13094.279814610192, 13100.60698179056, 12559.246445213224, 12708.237505749685, 12815.231086134861, 12863.807042894365, 13093.934530327382, 10148.543315550818, 10149.340292881014, 10211.846822297672, 10290.43402612856, 10478.266521343508, 3605.405108157151, 3701.68535674468, 3704.5369328833895, 3788.8484460621544, 3797.6392242736897, 47362.289565656545, 47513.76243118797, 47578.76210618959, 47738.28392574114, 47792.28311575329, 8699.695510657097, 8941.150590693873, 9016.233620142362, 9109.68116115946, 9177.403468774508, 17215.483535493957, 17483.56291092733, 17500.387486437914, 17550.912245438692, 17585.0, 7368.631568421558, 7534.666952751125, 7631.1605723370385, 7752.0697516298405, 7776.377889768805, 4120.835166593302, 4142.79286035697, 4159.563245859141, 4169.56219596944, 4206.369044643328, 3018.5623084653043, 3021.864016119236, 3036.9240768980953, 3050.054483110243, 3055.0834749575038, 564.6188822544766, 569.8432930944024, 571.7141429285357, 574.1588572740955, 596.8358701357162, 539.8738973447145, 547.5920439272687, 629.2449061126666, 665.3745479249586, 692.6675195905892, 8790.516521591246, 8860.911390886138, 8870.556472176366, 8917.197452229331, 9046.140616641409, 524.4571868116481, 531.1183435497134, 542.6608369768894, 543.2530270877544, 583.4690431707127, 4119.887630339791, 4121.754592769452, 4233.851815186454, 4329.978350108229, 4362.323839804835, 54117.45882541203, 55074.44925550773, 55093.72453137708, 55179.72410137924, 55859.0, 48930.0, 48937.2659410102, 49587.25619115716, 49832.0, 49898.25152622713, 43796.56203437925, 44315.0, 44438.0, 44485.0, 44510.77744611321, 8420.915790842013, 8573.271271941954, 8622.137786221328, 8668.176523230282, 8786.209241168326, 32427.513587295736, 32849.50725739163, 33019.33961320712, 33070.66929330772, 33126.33747325088, 39895.60104398919, 42849.785751071046, 43268.0, 43830.34254486249, 43894.56105438905, 10285.9485702571, 10495.790084198426, 11178.608748693756, 11213.71965700864, 11716.882831171579, 12175.269483830998, 12658.683532911382, 12743.10798244114, 12798.296093714935, 13117.868821311664, 11245.550177992789, 11662.650120496059, 11829.881701183222, 12005.699857503283, 12375.814362784386, 11358.829617555908, 11817.822732658846, 11880.702982425508, 12107.273563586214, 12363.258204507758, 11641.708957276136, 12122.212056216318, 12162.817557736818, 12254.080943929419, 12369.93815030919, 9335.85996210071, 9368.531573421165, 9433.528783050946, 9597.857886646723, 9666.371685840679, 9102.635894564144, 9160.816783664157, 9518.809623807347, 9551.808963820824, 9891.653792117242], "unit": "score", "name": "yui.html", "value": 6247.444076716085}], "name": "dromaeo_css", "value": 6867.932571435868}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 106.0, 112.0, 112.0, 111.0, 123.0, 112.0, 112.0, 110.0, 113.0], "unit": "score", "name": "ai-astar", "value": 112.5}, {"lowerIsBetter": true, "replicates": [149.0, 136.0, 159.0, 158.0, 128.0, 149.0, 150.0, 129.0, 166.0, 134.0], "unit": "score", "name": "audio-beat-detection", "value": 145.8}, {"lowerIsBetter": true, "replicates": [163.0, 163.0, 166.0, 164.0, 162.0, 164.0, 162.0, 166.0, 168.0, 160.0], "unit": "score", "name": "audio-dft", "value": 163.8}, {"lowerIsBetter": true, "replicates": [76.0, 76.0, 75.0, 74.0, 74.0, 77.0, 158.0, 76.0, 75.0, 76.0], "unit": "score", "name": "audio-fft", "value": 83.7}, {"lowerIsBetter": true, "replicates": [95.0, 98.0, 142.0, 96.0, 97.0, 96.0, 142.0, 96.0, 98.0, 140.0], "unit": "score", "name": "audio-oscillator", "value": 110.0}, {"lowerIsBetter": true, "replicates": [111.0, 111.0, 110.0, 110.0, 110.0, 110.0, 109.0, 110.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.1}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 147.0, 147.0, 146.0, 148.0, 146.0, 147.0, 146.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 146.8}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 96.0, 99.0, 97.0, 96.0, 97.0, 98.0, 97.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 97.1}, {"lowerIsBetter": true, "replicates": [61.0, 61.0, 61.0, 60.0, 62.0, 62.0, 61.0, 63.0, 68.0, 61.0], "unit": "score", "name": "json-parse-financial", "value": 62.0}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 69.0, 69.0, 72.0, 70.0, 69.0, 69.0, 71.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.6}, {"lowerIsBetter": true, "replicates": [91.0, 83.0, 84.0, 84.0, 85.0, 82.0, 82.0, 83.0, 83.0, 81.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.8}, {"lowerIsBetter": true, "replicates": [118.0, 117.0, 127.0, 126.0, 117.0, 121.0, 117.0, 124.0, 122.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.9}, {"lowerIsBetter": true, "replicates": [133.0, 146.0, 164.0, 143.0, 133.0, 143.0, 143.0, 147.0, 146.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 144.0}, {"lowerIsBetter": true, "replicates": [80.0, 67.0, 67.0, 66.0, 69.0, 68.0, 70.0, 67.0, 67.0, 76.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.7}], "name": "kraken", "value": 1519.8000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.897918065816], "unit": "score", "name": "Richards", "value": 210.25871200000006}, {"lowerIsBetter": false, "replicates": [187.89928598271325], "unit": "score", "name": "DeltaBlue", "value": 351.879996}, {"lowerIsBetter": false, "replicates": [278.9400278940028], "unit": "score", "name": "Encrypt", "value": 954.2588850000001}, {"lowerIsBetter": false, "replicates": [5208.333333333333], "unit": "score", "name": "Decrypt", "value": 51.10675199999996}, {"lowerIsBetter": false, "replicates": [1063.8297872340424], "unit": "score", "name": "RayTrace", "value": 695.5896600000003}, {"lowerIsBetter": false, "replicates": [715.8196134574088], "unit": "score", "name": "Earley", "value": 931.0488110000001}, {"lowerIsBetter": false, "replicates": [12432.098765432098], "unit": "score", "name": "Boyer", "value": 53.608245283018846}, {"lowerIsBetter": false, "replicates": [40720.0], "unit": "score", "name": "RegExp", "value": 22.37193025540274}, {"lowerIsBetter": false, "replicates": [635.3836398224477], "unit": "score", "name": "Splay", "value": 128.25479740518963}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 20255.37431435233}]} 05:31:31 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "20255.37"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1519.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6867.93"}}} 05:31:31 INFO - Return code: 0 05:31:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 05:31:31 INFO - # TBPL SUCCESS # 05:31:31 INFO - Running post-action listener: _resource_record_post_action 05:31:31 INFO - Running post-run listener: _resource_record_post_run 05:31:32 INFO - Total resource usage - Wall time: 1231s; CPU: 13.0%; Read bytes: 0; Write bytes: 549072896; Read time: 0; Write time: 1126648 05:31:32 INFO - install - Wall time: 16s; CPU: 17.0%; Read bytes: 0; Write bytes: 237096960; Read time: 0; Write time: 674980 05:31:32 INFO - run-tests - Wall time: 1215s; CPU: 13.0%; Read bytes: 0; Write bytes: 311975936; Read time: 0; Write time: 451668 05:31:32 INFO - Running post-run listener: _upload_blobber_files 05:31:32 INFO - Blob upload gear active. 05:31:32 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 05:31:32 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 05:31:32 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'] 05:31:32 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 05:31:32 INFO - (blobuploader) - INFO - Open directory for files ... 05:31:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:31:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:31:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:31:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:31:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:31:33 INFO - (blobuploader) - INFO - Done attempting. 05:31:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:31:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:31:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:31:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:31:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:31:34 INFO - (blobuploader) - INFO - Done attempting. 05:31:34 INFO - (blobuploader) - INFO - Iteration through files over. 05:31:34 INFO - Return code: 0 05:31:34 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 05:31:34 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 05:31:34 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0b37952433342e32040d68d3176fd1fbf9a413b62b1c99dbf72f16bb008e077d871c67b81a48860e13e6055ea2ef95a368479a59abd270ef5e18c204b89a40f9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/386e14a446169d1b1853b9c8f74b3178bbc1bccb5b7c2aad3c4288ae36969d975b5d19ba5f0d6c3a344cc0ea2a916b964407d3b49fc95d1b83c2f6f13132f638"} 05:31:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 05:31:34 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 05:31:34 INFO - Contents: 05:31:34 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0b37952433342e32040d68d3176fd1fbf9a413b62b1c99dbf72f16bb008e077d871c67b81a48860e13e6055ea2ef95a368479a59abd270ef5e18c204b89a40f9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/386e14a446169d1b1853b9c8f74b3178bbc1bccb5b7c2aad3c4288ae36969d975b5d19ba5f0d6c3a344cc0ea2a916b964407d3b49fc95d1b83c2f6f13132f638"} 05:31:34 INFO - Running post-run listener: copy_logs_to_upload_dir 05:31:34 INFO - Copying logs to upload dir... 05:31:34 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 05:31:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1279.760420 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-01-20 05:31:33.342576) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-20 05:31:33.346272) ========= 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=1861a34ebfea852630dec091000001fa-1453295209.804871-1078667273 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/0b37952433342e32040d68d3176fd1fbf9a413b62b1c99dbf72f16bb008e077d871c67b81a48860e13e6055ea2ef95a368479a59abd270ef5e18c204b89a40f9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/386e14a446169d1b1853b9c8f74b3178bbc1bccb5b7c2aad3c4288ae36969d975b5d19ba5f0d6c3a344cc0ea2a916b964407d3b49fc95d1b83c2f6f13132f638"} build_url:https://queue.taskcluster.net/v1/task/aURfFez5SfCqp43oWlq6Ow/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011319 build_url: 'https://queue.taskcluster.net/v1/task/aURfFez5SfCqp43oWlq6Ow/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/0b37952433342e32040d68d3176fd1fbf9a413b62b1c99dbf72f16bb008e077d871c67b81a48860e13e6055ea2ef95a368479a59abd270ef5e18c204b89a40f9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/386e14a446169d1b1853b9c8f74b3178bbc1bccb5b7c2aad3c4288ae36969d975b5d19ba5f0d6c3a344cc0ea2a916b964407d3b49fc95d1b83c2f6f13132f638"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-20 05:31:33.370531) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 05:31:33.370860) ========= 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=1861a34ebfea852630dec091000001fa-1453295209.804871-1078667273 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004525 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 05:31:33.452774) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-20 05:31:33.453114) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-20 05:31:33.453404) ========= ========= Total master_lag: 0.26 =========