builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-042 starttime: 1451523617.67 results: success (0) buildid: 20151230143005 builduid: de3abcc09bdf47b68aea7f2995deaba8 revision: 7077ef60118c0dcdd137eebc00f58844b3fa5555 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-30 17:00:17.672303) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-30 17:00:17.672836) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-30 17:00:17.673194) ========= 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=c402a24d74c70935940d60dd000001de-1451523617.635206-17506392 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.004877 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-30 17:00:17.695473) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-30 17:00:17.695788) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-30 17:00:17.709150) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 17:00:17.709566) ========= 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=c402a24d74c70935940d60dd000001de-1451523617.635206-17506392 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004602 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 17:00:17.759001) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-30 17:00:17.759313) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-30 17:00:17.759876) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 17:00:17.760209) ========= 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=c402a24d74c70935940d60dd000001de-1451523617.635206-17506392 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-30 17:00:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.3M=0s 2015-12-30 17:00:18 (43.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.102101 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 17:00:17.874834) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 17:00:17.875318) ========= 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=c402a24d74c70935940d60dd000001de-1451523617.635206-17506392 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022266 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 17:00:17.925162) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 17:00:17.925519) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 7077ef60118c0dcdd137eebc00f58844b3fa5555 --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/b2g-inbound --rev 7077ef60118c0dcdd137eebc00f58844b3fa5555 --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=c402a24d74c70935940d60dd000001de-1451523617.635206-17506392 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-30 17:00:18,593 truncating revision to first 12 chars 2015-12-30 17:00:18,593 Setting DEBUG logging. 2015-12-30 17:00:18,593 attempt 1/10 2015-12-30 17:00:18,593 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/7077ef60118c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-30 17:00:19,178 unpacking tar archive at: b2g-inbound-7077ef60118c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.880805 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 17:00:18.821123) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-30 17:00:18.821455) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-30 17:00:18.831501) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-30 17:00:18.831831) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-30 17:00:18.832313) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2015-12-30 17:00:18.832625) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'B2G-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound'] 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=c402a24d74c70935940d60dd000001de-1451523617.635206-17506392 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:00:19 INFO - MultiFileLogger online at 20151230 17:00:19 in /builds/slave/test-pgo 17:00:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 17:00:19 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 17:00:19 INFO - {'append_to_log': False, 17:00:19 INFO - 'base_work_dir': '/builds/slave/test-pgo', 17:00:19 INFO - 'blob_upload_branch': 'B2G-Inbound', 17:00:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 17:00:19 INFO - 'branch': 'B2G-Inbound', 17:00:19 INFO - 'buildbot_json_path': 'buildprops.json', 17:00:19 INFO - 'config_files': ('talos/linux_config.py',), 17:00:19 INFO - 'default_actions': ('clobber', 17:00:19 INFO - 'read-buildbot-config', 17:00:19 INFO - 'download-and-extract', 17:00:19 INFO - 'populate-webroot', 17:00:19 INFO - 'create-virtualenv', 17:00:19 INFO - 'install', 17:00:19 INFO - 'run-tests'), 17:00:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:00:19 INFO - 'download_minidump_stackwalk': True, 17:00:19 INFO - 'download_symbols': 'ondemand', 17:00:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:00:19 INFO - 'tooltool.py': '/tools/tooltool.py', 17:00:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:00:19 INFO - '/tools/misc-python/virtualenv.py')}, 17:00:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:00:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:00:19 INFO - 'installer_path': 'installer.exe', 17:00:19 INFO - 'log_level': 'info', 17:00:19 INFO - 'log_name': 'talos', 17:00:19 INFO - 'log_to_console': True, 17:00:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:00:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:00:19 INFO - 'opt_config_files': (), 17:00:19 INFO - 'pip_index': False, 17:00:19 INFO - 'sps_profile': False, 17:00:19 INFO - 'sps_profile_interval': 0, 17:00:19 INFO - 'suite': 'dromaeojs', 17:00:19 INFO - 'system_bits': '32', 17:00:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:00:19 INFO - 'title': 'talos-linux64-ix-042', 17:00:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:00:19 INFO - 'use_talos_json': True, 17:00:19 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 17:00:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:00:19 INFO - 'work_dir': 'build'} 17:00:19 INFO - ##### 17:00:19 INFO - ##### Running clobber step. 17:00:19 INFO - ##### 17:00:19 INFO - Running pre-action listener: _resource_record_pre_action 17:00:19 INFO - Running main action method: clobber 17:00:19 INFO - rmtree: /builds/slave/test-pgo/build 17:00:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 17:00:20 INFO - Running post-action listener: _resource_record_post_action 17:00:20 INFO - ##### 17:00:20 INFO - ##### Running read-buildbot-config step. 17:00:20 INFO - ##### 17:00:20 INFO - Running pre-action listener: _resource_record_pre_action 17:00:20 INFO - Running main action method: read_buildbot_config 17:00:20 INFO - Using buildbot properties: 17:00:20 INFO - { 17:00:20 INFO - "project": "", 17:00:20 INFO - "product": "firefox", 17:00:20 INFO - "script_repo_revision": "production", 17:00:20 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 17:00:20 INFO - "repository": "", 17:00:20 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 17:00:20 INFO - "buildid": "20151230143005", 17:00:20 INFO - "pgo_build": "True", 17:00:20 INFO - "basedir": "/builds/slave/test-pgo", 17:00:20 INFO - "buildnumber": 1080, 17:00:20 INFO - "slavename": "talos-linux64-ix-042", 17:00:20 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:00:20 INFO - "platform": "ubuntu64_hw", 17:00:20 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 17:00:20 INFO - "branch": "b2g-inbound", 17:00:20 INFO - "repo_path": "integration/b2g-inbound", 17:00:20 INFO - "revision": "7077ef60118c0dcdd137eebc00f58844b3fa5555", 17:00:20 INFO - "stage_platform": "linux64-pgo", 17:00:20 INFO - "builduid": "de3abcc09bdf47b68aea7f2995deaba8", 17:00:20 INFO - "slavebuilddir": "test" 17:00:20 INFO - } 17:00:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/Y9s-1YWTRbajX_2e3tC95A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 17:00:20 INFO - Running post-action listener: _resource_record_post_action 17:00:20 INFO - ##### 17:00:20 INFO - ##### Running download-and-extract step. 17:00:20 INFO - ##### 17:00:20 INFO - Running pre-action listener: _resource_record_pre_action 17:00:20 INFO - Running main action method: download_and_extract 17:00:20 INFO - mkdir: /builds/slave/test-pgo/build/tests 17:00:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:00:20 INFO - https://queue.taskcluster.net/v1/task/Y9s-1YWTRbajX_2e3tC95A/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 17:00:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y9s-1YWTRbajX_2e3tC95A/artifacts/public/build/test_packages.json 17:00:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y9s-1YWTRbajX_2e3tC95A/artifacts/public/build/test_packages.json 17:00:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y9s-1YWTRbajX_2e3tC95A/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 17:00:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y9s-1YWTRbajX_2e3tC95A/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 17:00:21 INFO - Downloaded 1302 bytes. 17:00:21 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 17:00:21 INFO - Using the following test package requirements: 17:00:21 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 17:00:21 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:00:21 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:00:21 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:00:21 INFO - u'jsshell-linux-x86_64.zip'], 17:00:21 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:00:21 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:00:21 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 17:00:21 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:00:21 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:00:21 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:00:21 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:00:21 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:00:21 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:00:21 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 17:00:21 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:00:21 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:00:21 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:00:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:00:21 INFO - https://queue.taskcluster.net/v1/task/Y9s-1YWTRbajX_2e3tC95A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:00:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y9s-1YWTRbajX_2e3tC95A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:00:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y9s-1YWTRbajX_2e3tC95A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:00:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y9s-1YWTRbajX_2e3tC95A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:00:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y9s-1YWTRbajX_2e3tC95A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:00:22 INFO - Downloaded 23201962 bytes. 17:00:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 17:00:22 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:00:22 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 17:00:23 INFO - Return code: 0 17:00:23 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:00:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:00:23 INFO - https://queue.taskcluster.net/v1/task/Y9s-1YWTRbajX_2e3tC95A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:00:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y9s-1YWTRbajX_2e3tC95A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:00:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y9s-1YWTRbajX_2e3tC95A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:00:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y9s-1YWTRbajX_2e3tC95A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:00:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y9s-1YWTRbajX_2e3tC95A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:00:24 INFO - Downloaded 23201962 bytes. 17:00:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 17:00:24 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:00:24 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 17:00:26 INFO - Return code: 0 17:00:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:00:26 INFO - https://queue.taskcluster.net/v1/task/Y9s-1YWTRbajX_2e3tC95A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:00:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y9s-1YWTRbajX_2e3tC95A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 17:00:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y9s-1YWTRbajX_2e3tC95A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 17:00:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y9s-1YWTRbajX_2e3tC95A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 17:00:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y9s-1YWTRbajX_2e3tC95A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:00:27 INFO - Downloaded 11132285 bytes. 17:00:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 17:00:27 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 17:00:27 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 17:00:27 INFO - Return code: 0 17:00:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:00:27 INFO - https://queue.taskcluster.net/v1/task/Y9s-1YWTRbajX_2e3tC95A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:00:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y9s-1YWTRbajX_2e3tC95A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:00:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y9s-1YWTRbajX_2e3tC95A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:00:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y9s-1YWTRbajX_2e3tC95A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:00:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y9s-1YWTRbajX_2e3tC95A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:00:29 INFO - Downloaded 54948204 bytes. 17:00:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Y9s-1YWTRbajX_2e3tC95A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:00:29 INFO - mkdir: /builds/slave/test-pgo/properties 17:00:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 17:00:29 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 17:00:29 INFO - Contents: 17:00:29 INFO - build_url:https://queue.taskcluster.net/v1/task/Y9s-1YWTRbajX_2e3tC95A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:00:29 INFO - Running post-action listener: _resource_record_post_action 17:00:29 INFO - Running post-action listener: set_extra_try_arguments 17:00:29 INFO - ##### 17:00:29 INFO - ##### Running populate-webroot step. 17:00:29 INFO - ##### 17:00:29 INFO - Running pre-action listener: _resource_record_pre_action 17:00:29 INFO - Running main action method: populate_webroot 17:00:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:00:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:00:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:00:29 INFO - '--tppagecycles', 17:00:29 INFO - '7'], 17:00:29 INFO - 'tests': ['tsvgm']}}, 17:00:29 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:00:29 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:00:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:00:29 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:00:29 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:00:29 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:00:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:00:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:00:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:00:29 INFO - 'talos_options': ['--e10s'], 17:00:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:00:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:00:29 INFO - 'tests': ['damp', 'tps']}, 17:00:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:00:29 INFO - 'talos_options': ['--e10s'], 17:00:29 INFO - 'tests': ['damp', 'tps']}, 17:00:29 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:00:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:00:29 INFO - 'other': {'tests': ['a11yr', 17:00:29 INFO - 'ts_paint', 17:00:29 INFO - 'tpaint', 17:00:29 INFO - 'sessionrestore', 17:00:29 INFO - 'sessionrestore_no_auto_restore']}, 17:00:29 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:00:29 INFO - 'tests': ['a11yr', 17:00:29 INFO - 'ts_paint', 17:00:29 INFO - 'tpaint', 17:00:29 INFO - 'sessionrestore', 17:00:29 INFO - 'sessionrestore_no_auto_restore']}, 17:00:29 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:00:29 INFO - 'tests': ['a11yr', 17:00:29 INFO - 'ts_paint', 17:00:29 INFO - 'tpaint', 17:00:29 INFO - 'sessionrestore', 17:00:29 INFO - 'sessionrestore_no_auto_restore']}, 17:00:29 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:00:29 INFO - 'tests': ['a11yr', 17:00:29 INFO - 'ts_paint', 17:00:29 INFO - 'tpaint', 17:00:29 INFO - 'sessionrestore', 17:00:29 INFO - 'sessionrestore_no_auto_restore']}, 17:00:29 INFO - 'other_l64': {'tests': ['a11yr', 17:00:29 INFO - 'ts_paint', 17:00:29 INFO - 'tpaint', 17:00:29 INFO - 'sessionrestore', 17:00:29 INFO - 'sessionrestore_no_auto_restore']}, 17:00:29 INFO - 'other_nol64': {'tests': ['a11yr', 17:00:29 INFO - 'ts_paint', 17:00:29 INFO - 'tpaint', 17:00:29 INFO - 'sessionrestore', 17:00:29 INFO - 'sessionrestore_no_auto_restore']}, 17:00:29 INFO - 'svgr': {'tests': ['tsvgx', 17:00:29 INFO - 'tsvgr_opacity', 17:00:29 INFO - 'tart', 17:00:29 INFO - 'tscrollx', 17:00:29 INFO - 'cart']}, 17:00:29 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:00:29 INFO - 'tests': ['tsvgx', 17:00:29 INFO - 'tsvgr_opacity', 17:00:29 INFO - 'tart', 17:00:29 INFO - 'tscrollx', 17:00:29 INFO - 'cart']}, 17:00:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:00:29 INFO - 'tests': ['tp5o']}, 17:00:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:00:29 INFO - 'talos_options': ['--e10s'], 17:00:29 INFO - 'tests': ['tp5o']}, 17:00:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:00:29 INFO - 'talos_options': ['--xperf_path', 17:00:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:00:29 INFO - 'tests': ['tp5n']}, 17:00:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:00:29 INFO - 'talos_options': ['--e10s', 17:00:29 INFO - '--xperf_path', 17:00:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:00:29 INFO - 'tests': ['tp5n']}}, 17:00:29 INFO - 'talos.zip': {'path': '', 17:00:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:00:29 INFO - Running post-action listener: _resource_record_post_action 17:00:29 INFO - ##### 17:00:29 INFO - ##### Running create-virtualenv step. 17:00:29 INFO - ##### 17:00:29 INFO - Running pre-action listener: _resource_record_pre_action 17:00:29 INFO - Running main action method: create_virtualenv 17:00:29 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 17:00:29 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 17:00:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 17:00:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:00:29 INFO - Using real prefix '/usr' 17:00:29 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 17:00:29 INFO - Installing distribute.............................................................................................................................................................................................done. 17:00:31 INFO - Installing pip.................done. 17:00:31 INFO - Return code: 0 17:00:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 17:00:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:00:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:00:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:31 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f928721cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x298a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a57360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae6540>, '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 0x2ae7440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae78f0>, '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': 'c402a24d74c70935940d60dd000001de-1451523617.635206-17506392', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:00:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 17:00:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:00:31 INFO - Using env: {'DISPLAY': ':0', 17:00:31 INFO - 'HOME': '/home/cltbld', 17:00:31 INFO - 'LANG': 'en_US.UTF-8', 17:00:31 INFO - 'LANGUAGE': 'en_US:en', 17:00:31 INFO - 'LOGNAME': 'cltbld', 17:00:31 INFO - 'MAIL': '/var/mail/cltbld', 17:00:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:31 INFO - 'MOZ_NO_REMOTE': '1', 17:00:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:00:31 INFO - 'NO_EM_RESTART': '1', 17:00:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:00:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:00:31 INFO - 'PWD': '/builds/slave/test-pgo', 17:00:31 INFO - 'SHELL': '/bin/bash', 17:00:31 INFO - 'SHLVL': '1', 17:00:31 INFO - 'TERM': 'linux', 17:00:31 INFO - 'TMOUT': '86400', 17:00:31 INFO - 'USER': 'cltbld', 17:00:31 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1451523617.635206-17506392', 17:00:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:31 INFO - '_': '/tools/buildbot/bin/python'} 17:00:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00:31 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 17:00:31 INFO - Cleaning up... 17:00:31 INFO - Return code: 0 17:00:31 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 17:00:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:00:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:00:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:31 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f928721cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x298a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a57360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae6540>, '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 0x2ae7440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae78f0>, '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': 'c402a24d74c70935940d60dd000001de-1451523617.635206-17506392', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:00:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 17:00:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 17:00:31 INFO - Using env: {'DISPLAY': ':0', 17:00:31 INFO - 'HOME': '/home/cltbld', 17:00:31 INFO - 'LANG': 'en_US.UTF-8', 17:00:31 INFO - 'LANGUAGE': 'en_US:en', 17:00:31 INFO - 'LOGNAME': 'cltbld', 17:00:31 INFO - 'MAIL': '/var/mail/cltbld', 17:00:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:31 INFO - 'MOZ_NO_REMOTE': '1', 17:00:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:00:31 INFO - 'NO_EM_RESTART': '1', 17:00:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:00:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:00:31 INFO - 'PWD': '/builds/slave/test-pgo', 17:00:31 INFO - 'SHELL': '/bin/bash', 17:00:31 INFO - 'SHLVL': '1', 17:00:31 INFO - 'TERM': 'linux', 17:00:31 INFO - 'TMOUT': '86400', 17:00:31 INFO - 'USER': 'cltbld', 17:00:31 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1451523617.635206-17506392', 17:00:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:31 INFO - '_': '/tools/buildbot/bin/python'} 17:00:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00:32 INFO - Downloading/unpacking psutil>=0.7.1 17:00:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:00:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:00:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:33 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 17:00:33 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 17:00:33 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 17:00:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:00:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:00:33 INFO - Installing collected packages: psutil 17:00:33 INFO - Running setup.py install for psutil 17:00:33 INFO - building 'psutil._psutil_linux' extension 17:00:33 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 17:00:34 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 17:00:34 INFO - building 'psutil._psutil_posix' extension 17:00:34 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 17:00:34 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 17:00:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:00:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:00:34 INFO - Successfully installed psutil 17:00:34 INFO - Cleaning up... 17:00:34 INFO - Return code: 0 17:00:34 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 17:00:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:00:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:00:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:34 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f928721cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x298a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a57360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae6540>, '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 0x2ae7440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae78f0>, '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': 'c402a24d74c70935940d60dd000001de-1451523617.635206-17506392', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:00:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 17:00:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 17:00:34 INFO - Using env: {'DISPLAY': ':0', 17:00:34 INFO - 'HOME': '/home/cltbld', 17:00:34 INFO - 'LANG': 'en_US.UTF-8', 17:00:34 INFO - 'LANGUAGE': 'en_US:en', 17:00:34 INFO - 'LOGNAME': 'cltbld', 17:00:34 INFO - 'MAIL': '/var/mail/cltbld', 17:00:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:34 INFO - 'MOZ_NO_REMOTE': '1', 17:00:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:00:34 INFO - 'NO_EM_RESTART': '1', 17:00:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:00:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:00:34 INFO - 'PWD': '/builds/slave/test-pgo', 17:00:34 INFO - 'SHELL': '/bin/bash', 17:00:34 INFO - 'SHLVL': '1', 17:00:34 INFO - 'TERM': 'linux', 17:00:34 INFO - 'TMOUT': '86400', 17:00:34 INFO - 'USER': 'cltbld', 17:00:34 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1451523617.635206-17506392', 17:00:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:34 INFO - '_': '/tools/buildbot/bin/python'} 17:00:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00:34 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:00:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:00:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:00:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:36 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:00:36 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 17:00:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:00:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:00:36 INFO - Installing collected packages: mozsystemmonitor 17:00:36 INFO - Running setup.py install for mozsystemmonitor 17:00:36 INFO - Successfully installed mozsystemmonitor 17:00:36 INFO - Cleaning up... 17:00:36 INFO - Return code: 0 17:00:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 17:00:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:00:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:00:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:36 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f928721cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x298a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a57360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae6540>, '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 0x2ae7440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae78f0>, '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': 'c402a24d74c70935940d60dd000001de-1451523617.635206-17506392', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:00:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 17:00:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:00:36 INFO - Using env: {'DISPLAY': ':0', 17:00:36 INFO - 'HOME': '/home/cltbld', 17:00:36 INFO - 'LANG': 'en_US.UTF-8', 17:00:36 INFO - 'LANGUAGE': 'en_US:en', 17:00:36 INFO - 'LOGNAME': 'cltbld', 17:00:36 INFO - 'MAIL': '/var/mail/cltbld', 17:00:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:36 INFO - 'MOZ_NO_REMOTE': '1', 17:00:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:00:36 INFO - 'NO_EM_RESTART': '1', 17:00:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:00:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:00:36 INFO - 'PWD': '/builds/slave/test-pgo', 17:00:36 INFO - 'SHELL': '/bin/bash', 17:00:36 INFO - 'SHLVL': '1', 17:00:36 INFO - 'TERM': 'linux', 17:00:36 INFO - 'TMOUT': '86400', 17:00:36 INFO - 'USER': 'cltbld', 17:00:36 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1451523617.635206-17506392', 17:00:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:36 INFO - '_': '/tools/buildbot/bin/python'} 17:00:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00:36 INFO - Downloading/unpacking blobuploader==1.2.4 17:00:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:00:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:00:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:38 INFO - Downloading blobuploader-1.2.4.tar.gz 17:00:38 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 17:00:38 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:00:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:00:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:00:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:00:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:38 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 17:00:38 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 17:00:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:00:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:00:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:00:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:39 INFO - Downloading docopt-0.6.1.tar.gz 17:00:39 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 17:00:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 17:00:39 INFO - Installing collected packages: blobuploader, requests, docopt 17:00:39 INFO - Running setup.py install for blobuploader 17:00:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:00:39 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 17:00:39 INFO - Running setup.py install for requests 17:00:39 INFO - Running setup.py install for docopt 17:00:39 INFO - Successfully installed blobuploader requests docopt 17:00:39 INFO - Cleaning up... 17:00:39 INFO - Return code: 0 17:00:39 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:00:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:00:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:00:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:39 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f928721cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x298a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a57360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae6540>, '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 0x2ae7440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae78f0>, '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': 'c402a24d74c70935940d60dd000001de-1451523617.635206-17506392', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:00:39 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 17:00:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:00:39 INFO - Using env: {'DISPLAY': ':0', 17:00:39 INFO - 'HOME': '/home/cltbld', 17:00:39 INFO - 'LANG': 'en_US.UTF-8', 17:00:39 INFO - 'LANGUAGE': 'en_US:en', 17:00:39 INFO - 'LOGNAME': 'cltbld', 17:00:39 INFO - 'MAIL': '/var/mail/cltbld', 17:00:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:39 INFO - 'MOZ_NO_REMOTE': '1', 17:00:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:00:39 INFO - 'NO_EM_RESTART': '1', 17:00:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:00:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:00:39 INFO - 'PWD': '/builds/slave/test-pgo', 17:00:39 INFO - 'SHELL': '/bin/bash', 17:00:39 INFO - 'SHLVL': '1', 17:00:39 INFO - 'TERM': 'linux', 17:00:39 INFO - 'TMOUT': '86400', 17:00:39 INFO - 'USER': 'cltbld', 17:00:39 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1451523617.635206-17506392', 17:00:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:39 INFO - '_': '/tools/buildbot/bin/python'} 17:00:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:00:39 INFO - Running setup.py (path:/tmp/pip-ZGR04v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:00:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:00:40 INFO - Running setup.py (path:/tmp/pip-7LN7L4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:00:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:00:40 INFO - Running setup.py (path:/tmp/pip-o6DDbV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:00:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:00:40 INFO - Running setup.py (path:/tmp/pip-xpaSsd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:00:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 17:00:40 INFO - Running setup.py (path:/tmp/pip-bHsoFK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 17:00:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:00:40 INFO - Running setup.py (path:/tmp/pip-4rlqhS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:00:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:00:40 INFO - Running setup.py (path:/tmp/pip-_dvQ8n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:00:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:00:40 INFO - Running setup.py (path:/tmp/pip-6A4btQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:00:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 17:00:40 INFO - Running setup.py (path:/tmp/pip-EWdaPn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 17:00:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 17:00:40 INFO - Running setup.py (path:/tmp/pip-jar2so-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 17:00:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:00:40 INFO - Running setup.py (path:/tmp/pip-ta7oD6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:00:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:00:40 INFO - Running setup.py (path:/tmp/pip-S3fKdO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:00:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:00:40 INFO - Running setup.py (path:/tmp/pip-DBc27X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:00:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:00:40 INFO - Running setup.py (path:/tmp/pip-m_6vLH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:00:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:00:40 INFO - Running setup.py (path:/tmp/pip-kci8ge-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:00:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 17:00:41 INFO - Running setup.py (path:/tmp/pip-76LMGX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 17:00:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 17:00:41 INFO - Running setup.py (path:/tmp/pip-2mUUL6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 17:00:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:00:41 INFO - Running setup.py install for manifestparser 17:00:41 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 17:00:41 INFO - Running setup.py install for mozcrash 17:00:41 INFO - Running setup.py install for mozdebug 17:00:41 INFO - Running setup.py install for mozdevice 17:00:41 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 17:00:41 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 17:00:41 INFO - Running setup.py install for mozfile 17:00:41 INFO - Running setup.py install for mozhttpd 17:00:41 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 17:00:41 INFO - Running setup.py install for mozinfo 17:00:41 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 17:00:41 INFO - Running setup.py install for mozInstall 17:00:41 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 17:00:41 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 17:00:41 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 17:00:41 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 17:00:41 INFO - Running setup.py install for mozleak 17:00:42 INFO - Running setup.py install for mozlog 17:00:42 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 17:00:42 INFO - Running setup.py install for moznetwork 17:00:42 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 17:00:42 INFO - Running setup.py install for mozprocess 17:00:42 INFO - Running setup.py install for mozprofile 17:00:42 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 17:00:42 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 17:00:42 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 17:00:42 INFO - Running setup.py install for mozrunner 17:00:42 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 17:00:42 INFO - Running setup.py install for mozscreenshot 17:00:42 INFO - Running setup.py install for moztest 17:00:42 INFO - Running setup.py install for mozversion 17:00:42 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 17:00:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:00:42 INFO - Cleaning up... 17:00:42 INFO - Return code: 0 17:00:42 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:00:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:00:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:00:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:42 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f928721cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x298a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a57360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae6540>, '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 0x2ae7440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae78f0>, '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': 'c402a24d74c70935940d60dd000001de-1451523617.635206-17506392', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:00:42 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 17:00:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:00:42 INFO - Using env: {'DISPLAY': ':0', 17:00:42 INFO - 'HOME': '/home/cltbld', 17:00:42 INFO - 'LANG': 'en_US.UTF-8', 17:00:42 INFO - 'LANGUAGE': 'en_US:en', 17:00:42 INFO - 'LOGNAME': 'cltbld', 17:00:42 INFO - 'MAIL': '/var/mail/cltbld', 17:00:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:42 INFO - 'MOZ_NO_REMOTE': '1', 17:00:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:00:42 INFO - 'NO_EM_RESTART': '1', 17:00:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:00:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:00:42 INFO - 'PWD': '/builds/slave/test-pgo', 17:00:42 INFO - 'SHELL': '/bin/bash', 17:00:42 INFO - 'SHLVL': '1', 17:00:42 INFO - 'TERM': 'linux', 17:00:42 INFO - 'TMOUT': '86400', 17:00:42 INFO - 'USER': 'cltbld', 17:00:42 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1451523617.635206-17506392', 17:00:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:42 INFO - '_': '/tools/buildbot/bin/python'} 17:00:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:00:43 INFO - Running setup.py (path:/tmp/pip-JpLliw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:00:43 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 17:00:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:00:43 INFO - Running setup.py (path:/tmp/pip-opaTjH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:00:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 17:00:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:00:43 INFO - Running setup.py (path:/tmp/pip-YTNNfr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:00:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 17:00:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:00:43 INFO - Running setup.py (path:/tmp/pip-_ksjC7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:00:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 17:00:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 17:00:43 INFO - Running setup.py (path:/tmp/pip-Ds7gTF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 17:00:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 17:00:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:00:43 INFO - Running setup.py (path:/tmp/pip-_C_eP2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:00:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 17:00:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:00:43 INFO - Running setup.py (path:/tmp/pip-Rh4UqM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:00:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 17:00:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:00:43 INFO - Running setup.py (path:/tmp/pip-dFsAbM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:00:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 17:00:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 17:00:43 INFO - Running setup.py (path:/tmp/pip-3pmWse-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 17:00:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 17:00:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 17:00:43 INFO - Running setup.py (path:/tmp/pip-1QtOYN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 17:00:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 17:00:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:00:43 INFO - Running setup.py (path:/tmp/pip-xdvzOh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:00:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 17:00:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:00:43 INFO - Running setup.py (path:/tmp/pip-_Uzszk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:00:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 17:00:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:00:44 INFO - Running setup.py (path:/tmp/pip-tIgFQy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:00:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 17:00:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:00:44 INFO - Running setup.py (path:/tmp/pip-uQc5BY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:00:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 17:00:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:00:44 INFO - Running setup.py (path:/tmp/pip-0WaBdT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:00:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 17:00:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 17:00:44 INFO - Running setup.py (path:/tmp/pip-IP2iOe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 17:00:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 17:00:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 17:00:44 INFO - Running setup.py (path:/tmp/pip-8zClPr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 17:00:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 17:00:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 17:00:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 17:00:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 17:00:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 17:00:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 17:00:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 17:00:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:00:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:00:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:46 INFO - Downloading blessings-1.5.1.tar.gz 17:00:46 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 17:00:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 17:00:46 INFO - Installing collected packages: blessings 17:00:46 INFO - Running setup.py install for blessings 17:00:46 INFO - Successfully installed blessings 17:00:46 INFO - Cleaning up... 17:00:46 INFO - Return code: 0 17:00:46 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 17:00:46 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 17:00:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 17:00:46 INFO - Reading from file tmpfile_stdout 17:00:46 INFO - Current package versions: 17:00:46 INFO - argparse == 1.2.1 17:00:46 INFO - blessings == 1.5.1 17:00:46 INFO - blobuploader == 1.2.4 17:00:46 INFO - docopt == 0.6.1 17:00:46 INFO - manifestparser == 1.1 17:00:46 INFO - mozInstall == 1.12 17:00:46 INFO - mozcrash == 0.16 17:00:46 INFO - mozdebug == 0.1 17:00:46 INFO - mozdevice == 0.47 17:00:46 INFO - mozfile == 1.2 17:00:46 INFO - mozhttpd == 0.7 17:00:46 INFO - mozinfo == 0.9 17:00:46 INFO - mozleak == 0.1 17:00:46 INFO - mozlog == 3.1 17:00:46 INFO - moznetwork == 0.27 17:00:46 INFO - mozprocess == 0.22 17:00:46 INFO - mozprofile == 0.28 17:00:46 INFO - mozrunner == 6.11 17:00:46 INFO - mozscreenshot == 0.1 17:00:46 INFO - mozsystemmonitor == 0.0 17:00:46 INFO - moztest == 0.7 17:00:46 INFO - mozversion == 1.4 17:00:46 INFO - psutil == 3.1.1 17:00:46 INFO - requests == 1.2.3 17:00:46 INFO - wsgiref == 0.1.2 17:00:46 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:00:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:00:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:00:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:46 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f928721cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x298a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a57360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae6540>, '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 0x2ae7440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae78f0>, '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': 'c402a24d74c70935940d60dd000001de-1451523617.635206-17506392', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:00:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 17:00:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:00:46 INFO - Using env: {'DISPLAY': ':0', 17:00:46 INFO - 'HOME': '/home/cltbld', 17:00:46 INFO - 'LANG': 'en_US.UTF-8', 17:00:46 INFO - 'LANGUAGE': 'en_US:en', 17:00:46 INFO - 'LOGNAME': 'cltbld', 17:00:46 INFO - 'MAIL': '/var/mail/cltbld', 17:00:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:46 INFO - 'MOZ_NO_REMOTE': '1', 17:00:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:00:46 INFO - 'NO_EM_RESTART': '1', 17:00:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:00:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:00:46 INFO - 'PWD': '/builds/slave/test-pgo', 17:00:46 INFO - 'SHELL': '/bin/bash', 17:00:46 INFO - 'SHLVL': '1', 17:00:46 INFO - 'TERM': 'linux', 17:00:46 INFO - 'TMOUT': '86400', 17:00:46 INFO - 'USER': 'cltbld', 17:00:46 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1451523617.635206-17506392', 17:00:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:46 INFO - '_': '/tools/buildbot/bin/python'} 17:00:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 17:00:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 17:00:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 17:00:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 17:00:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 17:00:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 17:00:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 17:00:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 17:00:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 17:00:46 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 17:00:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 17:00:46 INFO - Cleaning up... 17:00:46 INFO - Return code: 0 17:00:46 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 17:00:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:00:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:00:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:46 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f928721cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x298a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a57360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae6540>, '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 0x2ae7440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae78f0>, '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': 'c402a24d74c70935940d60dd000001de-1451523617.635206-17506392', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:00:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 17:00:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:00:46 INFO - Using env: {'DISPLAY': ':0', 17:00:46 INFO - 'HOME': '/home/cltbld', 17:00:46 INFO - 'LANG': 'en_US.UTF-8', 17:00:46 INFO - 'LANGUAGE': 'en_US:en', 17:00:46 INFO - 'LOGNAME': 'cltbld', 17:00:46 INFO - 'MAIL': '/var/mail/cltbld', 17:00:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:46 INFO - 'MOZ_NO_REMOTE': '1', 17:00:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:00:46 INFO - 'NO_EM_RESTART': '1', 17:00:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:00:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:00:46 INFO - 'PWD': '/builds/slave/test-pgo', 17:00:46 INFO - 'SHELL': '/bin/bash', 17:00:46 INFO - 'SHLVL': '1', 17:00:46 INFO - 'TERM': 'linux', 17:00:46 INFO - 'TMOUT': '86400', 17:00:46 INFO - 'USER': 'cltbld', 17:00:46 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1451523617.635206-17506392', 17:00:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:46 INFO - '_': '/tools/buildbot/bin/python'} 17:00:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00:46 INFO - Downloading/unpacking jsonschema 17:00:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:00:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:00:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:00:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 17:00:48 INFO - Downloading/unpacking functools32 (from jsonschema) 17:00:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:00:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:00:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:48 INFO - Downloading functools32-3.2.3-2.tar.gz 17:00:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 17:00:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 17:00:48 INFO - warning: no files found matching '*.txt' 17:00:48 INFO - no previously-included directories found matching 'build' 17:00:48 INFO - no previously-included directories found matching 'dist' 17:00:48 INFO - no previously-included directories found matching '.git*' 17:00:48 INFO - Installing collected packages: jsonschema, functools32 17:00:48 INFO - Running setup.py install for functools32 17:00:49 INFO - warning: no files found matching '*.txt' 17:00:49 INFO - no previously-included directories found matching 'build' 17:00:49 INFO - no previously-included directories found matching 'dist' 17:00:49 INFO - no previously-included directories found matching '.git*' 17:00:49 INFO - Successfully installed jsonschema functools32 17:00:49 INFO - Cleaning up... 17:00:49 INFO - Return code: 0 17:00:49 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 17:00:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:00:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:00:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:49 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f928721cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x298a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a57360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae6540>, '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 0x2ae7440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae78f0>, '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': 'c402a24d74c70935940d60dd000001de-1451523617.635206-17506392', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:00:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 17:00:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 17:00:49 INFO - Using env: {'DISPLAY': ':0', 17:00:49 INFO - 'HOME': '/home/cltbld', 17:00:49 INFO - 'LANG': 'en_US.UTF-8', 17:00:49 INFO - 'LANGUAGE': 'en_US:en', 17:00:49 INFO - 'LOGNAME': 'cltbld', 17:00:49 INFO - 'MAIL': '/var/mail/cltbld', 17:00:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:49 INFO - 'MOZ_NO_REMOTE': '1', 17:00:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:00:49 INFO - 'NO_EM_RESTART': '1', 17:00:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:00:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:00:49 INFO - 'PWD': '/builds/slave/test-pgo', 17:00:49 INFO - 'SHELL': '/bin/bash', 17:00:49 INFO - 'SHLVL': '1', 17:00:49 INFO - 'TERM': 'linux', 17:00:49 INFO - 'TMOUT': '86400', 17:00:49 INFO - 'USER': 'cltbld', 17:00:49 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1451523617.635206-17506392', 17:00:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:49 INFO - '_': '/tools/buildbot/bin/python'} 17:00:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00:49 INFO - Downloading/unpacking flake8 17:00:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:00:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:00:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:50 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:00:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 17:00:50 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:00:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:00:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:00:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:51 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:00:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 17:00:51 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:00:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:00:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:00:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 17:00:51 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:00:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:00:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:00:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 17:00:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 17:00:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:00:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:00:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:00:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:00:51 INFO - no previously-included directories found matching 'docs/_build' 17:00:51 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:00:51 INFO - Running setup.py install for pep8 17:00:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:00:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:00:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:00:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:00:51 INFO - no previously-included directories found matching 'docs/_build' 17:00:51 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 17:00:51 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:00:51 INFO - Cleaning up... 17:00:51 INFO - Return code: 0 17:00:51 INFO - Running post-action listener: _resource_record_post_action 17:00:51 INFO - Running post-action listener: _start_resource_monitoring 17:00:51 INFO - Starting resource monitoring. 17:00:51 INFO - ##### 17:00:51 INFO - ##### Running install step. 17:00:51 INFO - ##### 17:00:51 INFO - Running pre-action listener: _resource_record_pre_action 17:00:51 INFO - Running main action method: install 17:00:51 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 17:00:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 17:00:52 INFO - Reading from file tmpfile_stdout 17:00:52 INFO - Detecting whether we're running mozinstall >=1.0... 17:00:52 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 17:00:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 17:00:52 INFO - Reading from file tmpfile_stdout 17:00:52 INFO - Output received: 17:00:52 INFO - Usage: mozinstall [options] installer 17:00:52 INFO - Options: 17:00:52 INFO - -h, --help show this help message and exit 17:00:52 INFO - -d DEST, --destination=DEST 17:00:52 INFO - Directory to install application into. [default: 17:00:52 INFO - "/builds/slave/test-pgo"] 17:00:52 INFO - --app=APP Application being installed. [default: firefox] 17:00:52 INFO - mkdir: /builds/slave/test-pgo/build/application 17:00:52 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 17:00:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 17:01:08 INFO - Reading from file tmpfile_stdout 17:01:08 INFO - Output received: 17:01:08 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 17:01:08 INFO - Running post-action listener: _resource_record_post_action 17:01:08 INFO - ##### 17:01:08 INFO - ##### Running run-tests step. 17:01:08 INFO - ##### 17:01:08 INFO - Running pre-action listener: _resource_record_pre_action 17:01:08 INFO - Running main action method: run_tests 17:01:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 17:01:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 17:01:08 INFO - Python 2.7.3 17:01:08 INFO - Return code: 0 17:01:08 INFO - grabbing minidump binary from tooltool 17:01:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:01:08 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae6540>, '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 0x2ae7440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae78f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 17:01:08 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 17:01:08 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 17:01:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:01:08 INFO - Return code: 0 17:01:08 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 17:01:08 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 17:01:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 17:01:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 17:01:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 17:01:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 17:01:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 17:01:09 INFO - Return code: 0 17:01:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Y9s-1YWTRbajX_2e3tC95A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 17:01:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName B2G-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Y9s-1YWTRbajX_2e3tC95A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-042 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 17:01:09 INFO - Using env: {'DISPLAY': ':0', 17:01:09 INFO - 'HOME': '/home/cltbld', 17:01:09 INFO - 'LANG': 'en_US.UTF-8', 17:01:09 INFO - 'LANGUAGE': 'en_US:en', 17:01:09 INFO - 'LOGNAME': 'cltbld', 17:01:09 INFO - 'MAIL': '/var/mail/cltbld', 17:01:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 17:01:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 17:01:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:01:09 INFO - 'MOZ_NO_REMOTE': '1', 17:01:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 17:01:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:01:09 INFO - 'NO_EM_RESTART': '1', 17:01:09 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:01:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:01:09 INFO - 'PWD': '/builds/slave/test-pgo', 17:01:09 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 17:01:09 INFO - 'SHELL': '/bin/bash', 17:01:09 INFO - 'SHLVL': '1', 17:01:09 INFO - 'TERM': 'linux', 17:01:09 INFO - 'TMOUT': '86400', 17:01:09 INFO - 'USER': 'cltbld', 17:01:09 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1451523617.635206-17506392', 17:01:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:01:09 INFO - '_': '/tools/buildbot/bin/python'} 17:01:09 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Y9s-1YWTRbajX_2e3tC95A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 17:01:09 INFO - mozversion application_buildid: 20151230143005 17:01:09 INFO - mozversion application_changeset: 7077ef60118c0dcdd137eebc00f58844b3fa5555 17:01:09 INFO - mozversion application_display_name: Nightly 17:01:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:01:09 INFO - mozversion application_name: Firefox 17:01:09 INFO - mozversion application_remotingname: firefox 17:01:09 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 17:01:09 INFO - mozversion application_vendor: Mozilla 17:01:09 INFO - mozversion application_version: 46.0a1 17:01:09 INFO - mozversion platform_buildid: 20151230143005 17:01:09 INFO - mozversion platform_changeset: 7077ef60118c0dcdd137eebc00f58844b3fa5555 17:01:09 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 17:01:09 INFO - mozversion platform_version: 46.0a1 17:01:09 INFO - using testdate: 1451523669 17:01:09 INFO - actual date: 1451523669 17:01:09 INFO - starting webserver on 'localhost:58755' 17:01:09 INFO - SUITE-START | Running 3 tests 17:01:09 INFO - TEST-START | dromaeo_css 17:01:09 INFO - operating with platform_type : linux_ 17:01:09 INFO - Initialising browser for dromaeo_css test... 17:01:09 INFO - TEST-INFO | started process 26545 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpH6h0VN/profile http://localhost:58755/getInfo.html) 17:01:13 INFO - PROCESS | 26545 | __metrics Screen width/height:1600/1200 17:01:13 INFO - PROCESS | 26545 | colorDepth:24 17:01:13 INFO - PROCESS | 26545 | Browser inner width/height: 1024/697 17:01:13 INFO - PROCESS | 26545 | __metrics 17:01:13 INFO - PROCESS | 26545 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:01:13 INFO - PROCESS | 26545 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:01:14 INFO - TEST-INFO | 26545: exit 0 17:01:14 INFO - Browser initialized. 17:01:14 INFO - Running cycle 1/1 for dromaeo_css test... 17:01:14 INFO - TEST-INFO | started process 26640 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpH6h0VN/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:01:26 INFO - PROCESS | 26640 | RSS: Main: 149282816 17:01:26 INFO - PROCESS | 26640 | 17:02:17 INFO - PROCESS | 26640 | 1451523737821 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 17:04:26 INFO - PROCESS | 26640 | Cycle 1(1): loaded http://localhost:58755/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58755/tests/dromaeo/cssquery-ext.html) 17:04:27 INFO - PROCESS | 26640 | RSS: Main: 281182208 17:04:27 INFO - PROCESS | 26640 | 17:07:30 INFO - PROCESS | 26640 | Cycle 1(1): loaded http://localhost:58755/tests/dromaeo/cssquery-ext.html (next: http://localhost:58755/tests/dromaeo/cssquery-jquery.html) 17:07:30 INFO - PROCESS | 26640 | RSS: Main: 232820736 17:07:30 INFO - PROCESS | 26640 | 17:10:32 INFO - PROCESS | 26640 | Cycle 1(1): loaded http://localhost:58755/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58755/tests/dromaeo/cssquery-mootools.html) 17:10:33 INFO - PROCESS | 26640 | RSS: Main: 240144384 17:10:33 INFO - PROCESS | 26640 | 17:13:34 INFO - PROCESS | 26640 | Cycle 1(1): loaded http://localhost:58755/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58755/tests/dromaeo/cssquery-prototype.html) 17:13:35 INFO - PROCESS | 26640 | RSS: Main: 214765568 17:13:35 INFO - PROCESS | 26640 | 17:16:37 INFO - PROCESS | 26640 | Cycle 1(1): loaded http://localhost:58755/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58755/tests/dromaeo/cssquery-yui.html) 17:16:38 INFO - PROCESS | 26640 | RSS: Main: 218624000 17:16:38 INFO - PROCESS | 26640 | 17:19:41 INFO - PROCESS | 26640 | Cycle 1(1): loaded http://localhost:58755/tests/dromaeo/cssquery-yui.html (next: http://localhost:58755/tests/dromaeo/cssquery-dojo.html) 17:19:41 INFO - PROCESS | 26640 | RSS: Main: 258867200 17:19:41 INFO - PROCESS | 26640 | 17:19:41 INFO - PROCESS | 26640 | __start_tp_report 17:19:41 INFO - PROCESS | 26640 | _x_x_mozilla_page_load 17:19:41 INFO - PROCESS | 26640 | _x_x_mozilla_page_load_details 17:19:41 INFO - PROCESS | 26640 | |i|pagename|runs| 17:19:41 INFO - PROCESS | 26640 | |0;dojo.html;3137.654857965624;3220;3224.854881530331;3228.3220523690024;3259.804411735296;5216.452272511388;5332.466753324676;5343.599230057746;5381.408045115039;5443.836684899449;5292.894142117156;5309.123994540906;5406.053940560406;5421.241026256327;5428.212909128174;4880.682755620891;4905.852824415273;4922.384701912261;4935.333729946447;4946.950530494703;4859.076775412678;4939.20972644377;4961.082199793032;4994.650374473788;5017.222330538754;4828.348172996635;4838.201696720037;4927.137750893579;4940.110780059588;4953.90092198154;4814.807407703687;4822.590079843218;4824.903501929942;4847.660663753539;4859.319695242669;4781.95218047822;4819.253015782524;4840.225563909793;4842.83050093245;4862.44081930579;5080.542751152377;5179.378474583036;5187.974060129713;5198;5238.92141617876;5767.711614419262;5774.249347584787;5777.913331300034;5781.219535362757;5781.739821707991;5616.943830561683;5796.159556864273;5797.072468405077;5797.101449275369;5813.854653633651;5262.210668399733;5307.6019298552765;5316.41519432866;5322.7338633068575;5362.973185134088;5760.855978600484;5828.0966450200285;5829.387914269026;5831.912521312183;5853.297604287428;5446.455354464601;5555.8888822223325;5559.861003474945;5629.915551266734;5644.435556444323;5655.604107712421;5725.6850873202375;5728.856778580569;5729.512991395694;5780.42195780427;5660.745266463019;5672.829815105553;5686.2323586315315;5691.68695721731;5691.9715401423555;5579.442055794388;5701.971490142523;5709.058005429058;5728.914066289009;5729.742161602738;4374.168907907488;4433.1577000369825;4440.866773996785;4471.038726673781;4477.664175186874;3909.8240579173435;3937.586553411908;3963.980180099081;3982.6216509431556;3983.940240896389;5243.134882744381;5352.4915133062295;5353.116735738559;5353.277307563507;5355.919661205085;5750.827475175752;5802.071668533014;5809.331926828469;5810.883782324415;5877.0009098453365;5290.1800220965815;5317.069512835238;5322.2548843161985;5327.334083239595;5332.653377530448;4828.324034635154;4928.531789479994;4932.062908047459;4937.876553086202;4986.800527978913;5995.970020149872;6003.159557661931;6003.6097653651495;6008.699565021731;6009.819705408845;5779.653220806765;5782.85542861415;5783.710814459176;5784.4504772046585;5786.276715410574;5711.286089238845;5829.38791426911;5901.1443340714495;5901.734421950937;5963;5627.155926611041;5651.039323314964;5652.4064973178865;5662.85842853932;5697.401772813795;5659.603827732019;5707.714614269353;5707.9429205709075;5712.228849105318;5712.257406537124;5452.91820622683;5508.614396992172;5571.9721401392735;5589.077802162597;5633.239512665901;5538.889222215453;5548.778048878;5555.0834112371;5565.1930470082425;5597.944020559742;5474.2609747683555;5474.835754927359;5477.20580515815;5477.20580515831;5481.753321100639;5480.753366098455;5482.369527504388;5540.750666219949;5603.299587551556;5605.32736071674;5424.050791111618;5429.592780541396;5431.8098866539485;5450.918236226539;5467.863303417287 17:19:41 INFO - PROCESS | 26640 | |1;ext.html;498.60111910471636;529.3277537527342;553.0101118996994;558.4276116980095;570.7060863655219;25655.74344256557;25909.74090259097;36827.447588286195;37561.43657845134;37562.624373756254;39632.80183599085;40004.59995400052;40029;40110.7994460028;40131.398029029515;7225.277472252786;8446;8671.219590236877;8676.219140277373;8678.826423471526;7272.345488905998;10102.444365559892;10377.740556486073;10382.428966406844;10391.792164156712;10062.597496100147;10165.949170254175;10169.745756356113;10170.084692377684;10177.23670724695;7457.254274572553;7510.737124200627;9975.850362244571;10063.547140378663;10200.234982376278;9889.604415823358;9961.053699898497;9964.352317099365;10014.849777253346;10023.799524009552;37078;37662.81168594139;37678.811605941795;37691.81154094212;37693.24613507742;2981.791274610778;3007.8646460909313;3058.29659178388;3096.2259435141214;3098.2564184595535;28824.855875720696;29706.554401683992;30080.548791768142;30240.84879575588;30295.242618934484;3837;3933.5465283209455;3933.8623148189677;3988.7008474364247;4043.2722110020186;255069;256411;256561;256634.99999999814;257062;44224.77887610606;45163;58998.70500647555;59355.703221483614;59380.406195938354;63881;64680.676596616715;65440;65476.34523654702;65534.344656553774;15633.452829151152;15645.843541564665;15711.057336559843;15858.207089645472;15860.762088568681;12031.87968120325;12153.270803751626;12162.5134994601;12171.939140304241;12173.208741431956;19435.514112147026;19677.606447871247;19730;20320.28878989228;20400.489987750425;7604.163542010375;7754.689812407553;7874.803129921684;7895.289423951872;7927.682892684344;964.5129209749032;966.2415004221652;982.5627595719836;985.4186030242191;1075.961696962435;28378;28657.28356791097;29084.272893177418;29108.417831643674;29726.702732972826;958.942463452195;974.0454354732402;976.770458942148;1065.6856227412932;1093.294824837991;13808;13897.583072507841;14145.646358841112;14149;14203.218822964629;251145;253823;254651;254927;254967;48462.75768621205;48958.5104148954;49099.263511047364;49115.50884491109;49234.26148607774;1341.3025226881966;1356.6472717093627;1365.863413658626;1382.6958069224754;1385.528920167148;23462;26490;26842.731572684024;28458.146255612366;29468.263293417836;43526.347104794084;43984.12031759411;44097.338539922566;44116.77941610271;44125;237753;241878.95302617576;241896;242773;296550;23738.406539836644;32129;32357;32683.097535369885;32837.50743738894;37938;38460.61539384571;38769;38811.22377552489;39630.40554391744;32479.35041299208;32709.182270442478;32809.343813124084;33076.503852441754;33352.83323583366;32431.547131604973;34775.65224347724;35400.46899296564;35423.64576354306;35452.64547354596;35960.82019589885;36097.458538122475;36476.27047459089;36882.89351319465;37180.62819371772;27311.45377092487;27819.721802781714;31106.37787244197;31788;32182.67817321797;23290;23336.299911002698;23396.883015585496;23611.29166125019;23687.289381318587 17:19:41 INFO - PROCESS | 26640 | |2;jquery.html;344.88618755810575;347.61588444768546;350.3640891781417;352.8976596786932;358.16368778901267;16198.919005404987;16339.754903676454;16498.34006639733;16872.66254674906;16876.66246675066;15663;16020;16021.519354419357;16132.516024519255;16185.595360116004;5367.382750983647;5519.972400137994;5520.199571062193;5527.060399732055;5533.280673512438;5300.178472336794;5517.972410137943;5518;5519.779208831642;5520.392756796749;3734.757240779354;3853.7109716771215;3858.2862170498406;5493.725313734317;5506.779728810843;3845.8846234612865;3991.840326386941;6039.305479869828;6039.849003774941;6041.848953776125;5148.150555158394;5377.4084850666395;5387.299651045339;5388.245645609618;5391.029614669358;10910.781784364348;11148.331100134017;12756;12959.416826242747;12960.0279979001;2156.4177672028463;2162.859414138076;2188.124750099957;2193.462601662587;2211.8783466909313;9494.572744226458;9740.074692904163;10258.538365773484;10428.84356734642;13011.674708132277;1844.1056087797408;1847.4734700610395;1864.869459137861;1878.605492846504;1907.8569107317007;59385.703071484364;59855.80288394251;60595.697021514614;61318;62317.37682623161;10205.642802501878;10443.738906527245;10453.268271221094;10459.686209413578;10524.052835244865;13517.59447216585;13539.390727417092;13547.86452135466;13600.523981660594;13644.522441714493;7374.188839227681;7506.061742282215;7560.395168386516;7704.768856934301;7844.137144914055;7261.3101755333155;7272.672729727175;7276.527025743309;7318.451116166309;7452.105747310357;4411.625011874026;4473.955260447419;4503.842365517191;4533.093381323749;4540.545945405499;1720.2688857235626;1726.3008481564987;1726.413019573326;1772.53027947594;1838.5955089880206;914.5610107148473;1010.9191264698807;1042.7393151712072;1059.2532264753331;1068.4497483795851;16189;16777.496675099766;16954.321827127023;17054.488365349058;17340.30638774435;808.9150639182918;921.4425272710048;923.3702515060922;951.205743204432;1011.3780025284544;9637.614495420105;9684.46735429558;9901.801963960825;10106.14097801695;10168.186545076376;521389;522126;525517;553753;559270;58132;75523.24476755272;79071;79466;83214.58392707998;1169.976600468003;1175.400545721688;1212.5816593275483;1223.1071317937956;1249.188027781931;15702;15778.447754329003;15886.52340429789;15992.92003539975;16143.19284035817;18685.71971420457;23495.765042349358;24923.878425470535;35792.82103589465;36126.63873361233;45498.772506137255;46297.305540416244;46750.064998700516;48991.51008490012;49163;9766.121049105615;9840.3603765755;9907.405555666683;9919.206463483048;9952.502374881082;17032.744508832624;17229.74155387645;17397.826021740126;17596.73604895953;17898.731519026966;13893;13989.790153147507;14334.569962901129;14772.63068423298;14846.777298340317;14296.285185740879;14337.139771613736;14426.42294308216;14526.418943242152;14958.252087395369;14236.644083897985;14264.928675356558;14357.85642143607;14626.780598290821;14751.557453276419;9730.902690973;9737;9754.707358779247;9812.901870981199;9863.210943124677;13647.79528307096;13879.306034698022;13899.235542045284;14498.927505362828;14531.564053078424 17:19:41 INFO - PROCESS | 26640 | |3;mootools.html;1109.1681239070697;1436.9640758981027;1444.6243976566093;1584.6989072076306;1767.2400867626923;6430.356964303567;7163;7277.2722727727205;7287.744928927488;7288.3804876585555;7036.964815175917;7175.964120179405;7191.532550384234;7221.061262035928;7226.674799634016;1913.2155816115396;1950.0834607734341;1952.2678995376734;2152.956940861182;2196.6814811852273;2188.2559929624003;2220.5669894370603;2220.844540882139;2221.4002219400754;2222.633265511197;2151.2900742754855;2169.5877783221135;2242.7532971373134;2246.05665620439;2248.4603695113137;2162.318869556085;2182.3562049195366;2225.888705564715;2256.458449972003;2256.5938131136472;2220.837798101127;2230.944226394337;2236.630955892276;2259.751427342991;2262.8416010879246;7281.526700764433;7339.266073392671;7350.522216055992;7372.889406658905;7373.225811289844;4424.601785839258;4485.730856148642;4496.033352829158;4511.8646440606835;4512.075024619945;2877.9280517987218;2901.9854900725363;2951.852407379644;2958.8668509917106;2975.3751712140474;975.6048800235916;977.4721650308825;991.122856272197;1014.3812274512542;1051.7423231308303;9892.653757118467;9967.90032099677;9971.850422243671;9974.351667141613;9986.251031172691;3993.940090898639;4025.054112283611;4080.0819815541267;4082.795860207037;4113.9794301028305;8626.698065567674;8629.43908645936;8641.135886411434;8642.95678521616;8643.222110010129;4497.392851964943;4499.370088187657;4504.25679762842;4509.368688383629;4511.233090374644;4117.197146556393;4123.072308730511;4127.834886604503;4129.8967525811495;4130.669546436278;3135.7961732487315;3177.586913701204;3298.1259966109;3404.9148771280916;3466.9479957800654;1114.359243435028;1128.1707944660668;1133.444612140062;1136.3920302638048;1143.651186388143;902.801383695599;944.2021491839384;1000.3397757480028;1000.5397517142051;1007.0734923870057;6640.966795165993;6706.429953454011;6712.463002959751;6713.2279787824045;6713.899291510631;1044.1229367331325;1066.4544369279622;1074.3607553505651;1123.2586492914636;1155.7861795567846;5026.623003274769;5157.406898206679;5191.532762051434;5198.584113270929;5202.869928251748;8626.18051285127;8683.739487815375;8710.477371357612;8713.695020674246;8779.736607901774;8509.191626795444;8518.616662250213;8568.657253709907;8615.13848615146;8686.86969695455;6737.9326206737305;6821.283765204681;6830.556013859084;6912.688928998207;6919.550229235084;6459.321771213955;6490.091387205701;6490.448311893542;6510.44661203803;6518.804435866931;7491.662875170739;7492.063492063492;7747.147813740371;7750.99237099196;7758.92241077582;7798.649060792164;7814.882776758467;7911.28798408146;7930.881036784568;7935.404844636791;5976.760929562769;6094.08588711679;6097.420745029215;6098.146259523759;6108.72510737009;6321.8735625288155;6453.16108905858;6460.580062295936;6566.80299591013;6910.585364878123;6481.708323125565;6578.934210657832;6625.867482650417;6663.400293973566;6762.289959554176;6371.235451745635;6411.358864113738;6426.742930282736;6472.417482426604;6680.63256520896;6593.87904056302;6621.702023409054;6630.602163870183;6632.966835165793;6634.237062737847;6110.69446527663;6133.233345831771;6147.631142131308;6246.094316324198;6246.219222597176;6021.217241758543;6110.1445797587485;6114.908276375947;6126.632402055891;6236 17:19:41 INFO - PROCESS | 26640 | |4;prototype.html;327.6101439287248;332.8651895982125;334.07294757049186;336.9561956945598;340.00717903721124;5893.263342082239;5918.556108291879;5949.196858424117;5954;5985;5629.8592535186535;5703.7148142592805;5777.364489906107;5851;5887.558433117522;4594.540545945404;4619.445666520022;4624.445066592014;4629.560191781792;4648.837290694826;4380.693351465398;4590.885227869297;4591.403117594725;4598.333241679954;4602.539746025387;4404.955950440487;4414.4923333816705;4479.037007043485;4506.77466126694;4548.135854187711;4502.212112880233;4542.068875880453;4543.023250001249;4548.795304211319;4555.589996900295;4023.7384570002855;4029.6977726670616;4031.8992025199314;4033.8184781684895;4034.6570541504007;5484.424135465799;5617.410171931929;5622.353429355636;5623.690697011662;5631.2960879890015;5302.761375738101;5318.388385335697;5319.5478384337375;5321.388040375367;5323;6217.2539295284405;6241.095041218998;6244.750209991595;6249.375062493759;6251.12484252205;4427.911441771146;4447.955520444819;4457.888552786174;4458.4426946631675;4464.084862603158;6329.556931014831;6499.610023398611;6510.9023364649565;6512.674366281714;6515.413612774825;4580.267157254823;4580.358749775034;4580.725156490621;4584.633229341644;4594.97702511492;4632.536746325341;4634.304854271819;4639.327297541838;4642.489326174185;4643.6517261205545;5257.78968841242;5296.708681022581;5298.602604804578;5310.283111779938;5314.043472175045;6110.877782444326;6281.7173227204885;6295.433410993032;6307.24313082433;6319.368063193736;1621.3271492330787;1621.5216511129245;1635.803703555581;1637.5742307000266;1641.3352592200179;1125.201107213871;1126.1328776841785;1126.1553834624033;1148.7530181011123;1150.2810743285447;5970.34326224115;5977.760889564455;5981.581289309706;5983.37174596661;5983.670898100646;6415.807525774234;6435.452986496107;6457.031445283245;6472.093906853044;6472.931966225614;5846.386129456431;5871.735771890275;5947.762089516371;6064.302605200371;6116.021436570128;3481.721462283011;3493.5633045869267;3500.8774692886136;3503.4394496880377;3503.737219708532;6712.765053223114;6778.118844550177;6780.694868730919;6785.050092986986;6787.864242715217;6562.967185164139;6662.933370666231;6686.699098540577;6688.799336019927;6709.93290067093;6722.798316050428;6776.728930842711;6782.084418603426;6784.728610855609;6786.558873673195;6506.772262970962;6514.902276465762;6516.674166291761;6519.315471875385;6523.445507131947;6326.493880489457;6443.871122577429;6449.967750161407;6458.7093580789915;6462.063000864754;6701.095352127595;6759.256481787098;6761.560498567577;6766;6767.39093481589;4616.16908956391;4618.076384723136;4619.584237418649;4619.976900115478;4622.029373831533;6431.1317972073175;6511.641859697762;6534.444572211415;6535.57518761279;6535.705893234721;6333.493320534439;6334.556581039283;6342.270638876404;6345.682715864281;6353.142325786144;6326;6328.430441260309;6334.651594162181;6338.714757836001;6344.143540621957;6068.786242751379;6190.071489276645;6212.06818977157;6213.254409470893;6215.720292586754;6347.841303967438;6350.650714210578;6351.618902865843;6358.205224346957;6367.108604795239;6193.81418557444;6202.782902598387;6203.131561581292;6209.906851397142;6219.502439804714 17:19:41 INFO - PROCESS | 26640 | |5;yui.html;838.4885220015793;851.5146366571053;851.5529347092777;856.5931182688224;860.2000139869922;13682.04225704201;13932.582022539314;13942.860571394283;13961.790573141398;13974.091684040543;13096.541621043265;14255.429782808702;14696.265186740673;14709.11745295283;14718;510.30343581011834;811.6672164412593;825.9215374539409;826.1738261738262;826.9875951860727;513.5095983335905;517.5135372749603;520.8020952038239;813.032491335309;829.85062688716;862.7756783236372;868.2099289646424;873.8601823708208;874.6457684637732;874.9868751968726;855.1149560205158;865.5196366016858;866.030046348091;866.1468453573225;866.23338345564;468.33262600794075;475.4651017605194;476.57346674725926;624.9812505624793;625.4558534075384;13343.799843002364;13474.19154850712;13477.86522134776;13481.528146514825;13542.119762215523;11663.883361166365;12095.637130886087;12153.210041347284;12619.747605047847;12847.164934279335;9724.319297649168;10211.897881021243;10257.43584102874;10329.276950613461;10628.415437150954;3576.8032758198287;3601.7478776485655;3613.674769270778;3662.9084272893124;3739.813009349549;48127.51872481265;48264.758676206395;48386.7580662098;48610.27084593734;49085;10077.798444031077;10329.483525823678;10378;10439.582416703246;10451.16390688743;17893.28426862937;17935.282588696566;17963.101844907702;17989.100544972698;17989.460316190536;7072.222055573883;7144.821379465555;7205.531640443354;7215.206327303992;7363.77908662741;4018.6383225509257;4098.4876890388705;4149.605787450188;4202.894927626772;4381.101874115799;3056.7096125868006;3058.3271680230314;3075.185075954874;3077.692230776949;3090.520969249725;561.4722161168488;566.2779955556616;567.6934455394041;572.8081092833947;588.6409290332894;525.6977238088115;558.0178885162144;562.6989560585067;600.8467840700594;609.6921054867264;7493.213212612706;7807.570583617842;7920;7962.960185199153;8045.678172873137;461.6791330025667;511.63929429751937;597.8535258861607;611.5780111722897;625.2309659119309;3443.345764304774;3518.1204698825295;3536.717062634983;3594.4788005739542;3614.8915532534065;54439.45560544423;55559.72220138874;55650.443495565334;55852.720736396055;58997.70501147467;49832.252516212284;50598.49401506012;50895.23657145146;51407.7429612857;53311;44644.55355446469;44804.55195448004;45250.64248072563;45959;46336.5366346339;7773.494722842997;7776.7278145264645;8287.62705678234;8316.875246871181;8465.111163328009;35455.82272088623;35658.46512302369;35667.46498802572;37199;37308.6269137316;40743.388849166695;41318.58681413268;44182.55817441913;45531.31703024391;46544.301835471815;9835.65575204893;9846.852297215404;9951.900480995097;10078.344907580984;10121.69634910954;10353.74115647115;10355.94822025885;10418.791624167627;11453.19827612059;11599.130065244972;10399.32404393712;10549.419781912069;10663.786724265627;10695.251332406657;11021.393823339473;9738.75653108678;10058.19534437258;10127.442990635585;10355.43045132525;10373.896261037595;7647.426443016685;10170.745731356776;10285.331453455801;10510.579576817148;10579.5239214234;8855.114488551093;8981.191692747683;9037.68368107113;9162.450252984841;9198.126178013077;8436;8618.65525379003;8786.769852220566;8904.19862212404;8906.287497000354 17:19:41 INFO - PROCESS | 26640 | __end_tp_report 17:19:41 INFO - PROCESS | 26640 | __start_cc_report 17:19:41 INFO - PROCESS | 26640 | _x_x_mozilla_cycle_collect,1104 17:19:41 INFO - PROCESS | 26640 | __end_cc_report 17:19:41 INFO - PROCESS | 26640 | __startTimestamp1451524781493__endTimestamp 17:19:41 INFO - PROCESS | 26640 | 17:19:41 INFO - PROCESS | 26640 | ------- Summary: start ------- 17:19:41 INFO - PROCESS | 26640 | Number of tests: 6 17:19:41 INFO - PROCESS | 26640 | 17:19:41 INFO - PROCESS | 26640 | [#0] dojo.html Cycles:165 Average:5310.12 Median:5474.26 stddev:581.39 (10.6%) stddev-sans-first:557.63 17:19:41 INFO - PROCESS | 26640 | Values: 3137.7 3220.0 3224.9 3228.3 3259.8 5216.5 5332.5 5343.6 5381.4 5443.8 5292.9 5309.1 5406.1 5421.2 5428.2 4880.7 4905.9 4922.4 4935.3 4947.0 4859.1 4939.2 4961.1 4994.7 5017.2 4828.3 4838.2 4927.1 4940.1 4953.9 4814.8 4822.6 4824.9 4847.7 4859.3 4782.0 4819.3 4840.2 4842.8 4862.4 5080.5 5179.4 5188.0 5198.0 5238.9 5767.7 5774.2 5777.9 5781.2 5781.7 5616.9 5796.2 5797.1 5797.1 5813.9 5262.2 5307.6 5316.4 5322.7 5363.0 5760.9 5828.1 5829.4 5831.9 5853.3 5446.5 5555.9 5559.9 5629.9 5644.4 5655.6 5725.7 5728.9 5729.5 5780.4 5660.7 5672.8 5686.2 5691.7 5692.0 5579.4 5702.0 5709.1 5728.9 5729.7 4374.2 4433.2 4440.9 4471.0 4477.7 3909.8 3937.6 3964.0 3982.6 3983.9 5243.1 5352.5 5353.1 5353.3 5355.9 5750.8 5802.1 5809.3 5810.9 5877.0 5290.2 5317.1 5322.3 5327.3 5332.7 4828.3 4928.5 4932.1 4937.9 4986.8 5996.0 6003.2 6003.6 6008.7 6009.8 5779.7 5782.9 5783.7 5784.5 5786.3 5711.3 5829.4 5901.1 5901.7 5963.0 5627.2 5651.0 5652.4 5662.9 5697.4 5659.6 5707.7 5707.9 5712.2 5712.3 5452.9 5508.6 5572.0 5589.1 5633.2 5538.9 5548.8 5555.1 5565.2 5597.9 5474.3 5474.8 5477.2 5477.2 5481.8 5480.8 5482.4 5540.8 5603.3 5605.3 5424.1 5429.6 5431.8 5450.9 5467.9 17:19:41 INFO - PROCESS | 26640 | 17:19:41 INFO - PROCESS | 26640 | [#1] ext.html Cycles:180 Average:42351.26 Median:32394.27 stddev:66180.39 (204.3%) stddev-sans-first:66291.44 17:19:41 INFO - PROCESS | 26640 | Values: 498.6 529.3 553.0 558.4 570.7 25655.7 25909.7 36827.4 37561.4 37562.6 39632.8 40004.6 40029.0 40110.8 40131.4 7225.3 8446.0 8671.2 8676.2 8678.8 7272.3 10102.4 10377.7 10382.4 10391.8 10062.6 10165.9 10169.7 10170.1 10177.2 7457.3 7510.7 9975.9 10063.5 10200.2 9889.6 9961.1 9964.4 10014.8 10023.8 37078.0 37662.8 37678.8 37691.8 37693.2 2981.8 3007.9 3058.3 3096.2 3098.3 28824.9 29706.6 30080.5 30240.8 30295.2 3837.0 3933.5 3933.9 3988.7 4043.3 255069.0 256411.0 256561.0 256635.0 257062.0 44224.8 45163.0 58998.7 59355.7 59380.4 63881.0 64680.7 65440.0 65476.3 65534.3 15633.5 15645.8 15711.1 15858.2 15860.8 12031.9 12153.3 12162.5 12171.9 12173.2 19435.5 19677.6 19730.0 20320.3 20400.5 7604.2 7754.7 7874.8 7895.3 7927.7 964.5 966.2 982.6 985.4 1076.0 28378.0 28657.3 29084.3 29108.4 29726.7 958.9 974.0 976.8 1065.7 1093.3 13808.0 13897.6 14145.6 14149.0 14203.2 251145.0 253823.0 254651.0 254927.0 254967.0 48462.8 48958.5 49099.3 49115.5 49234.3 1341.3 1356.6 1365.9 1382.7 1385.5 23462.0 26490.0 26842.7 28458.1 29468.3 43526.3 43984.1 44097.3 44116.8 44125.0 237753.0 241879.0 241896.0 242773.0 296550.0 23738.4 32129.0 32357.0 32683.1 32837.5 37938.0 38460.6 38769.0 38811.2 39630.4 32479.4 32709.2 32809.3 33076.5 33352.8 32431.5 34775.7 35400.5 35423.6 35452.6 35960.8 36097.5 36476.3 36882.9 37180.6 27311.5 27819.7 31106.4 31788.0 32182.7 23290.0 23336.3 23396.9 23611.3 23687.3 17:19:41 INFO - PROCESS | 26640 | 17:19:41 INFO - PROCESS | 26640 | [#2] jquery.html Cycles:180 Average:28291.21 Median:12853.82 stddev:87642.62 (681.8%) stddev-sans-first:87863.35 17:19:41 INFO - PROCESS | 26640 | Values: 344.9 347.6 350.4 352.9 358.2 16198.9 16339.8 16498.3 16872.7 16876.7 15663.0 16020.0 16021.5 16132.5 16185.6 5367.4 5520.0 5520.2 5527.1 5533.3 5300.2 5518.0 5518.0 5519.8 5520.4 3734.8 3853.7 3858.3 5493.7 5506.8 3845.9 3991.8 6039.3 6039.8 6041.8 5148.2 5377.4 5387.3 5388.2 5391.0 10910.8 11148.3 12756.0 12959.4 12960.0 2156.4 2162.9 2188.1 2193.5 2211.9 9494.6 9740.1 10258.5 10428.8 13011.7 1844.1 1847.5 1864.9 1878.6 1907.9 59385.7 59855.8 60595.7 61318.0 62317.4 10205.6 10443.7 10453.3 10459.7 10524.1 13517.6 13539.4 13547.9 13600.5 13644.5 7374.2 7506.1 7560.4 7704.8 7844.1 7261.3 7272.7 7276.5 7318.5 7452.1 4411.6 4474.0 4503.8 4533.1 4540.5 1720.3 1726.3 1726.4 1772.5 1838.6 914.6 1010.9 1042.7 1059.3 1068.4 16189.0 16777.5 16954.3 17054.5 17340.3 808.9 921.4 923.4 951.2 1011.4 9637.6 9684.5 9901.8 10106.1 10168.2 521389.0 522126.0 525517.0 553753.0 559270.0 58132.0 75523.2 79071.0 79466.0 83214.6 1170.0 1175.4 1212.6 1223.1 1249.2 15702.0 15778.4 15886.5 15992.9 16143.2 18685.7 23495.8 24923.9 35792.8 36126.6 45498.8 46297.3 46750.1 48991.5 49163.0 9766.1 9840.4 9907.4 9919.2 9952.5 17032.7 17229.7 17397.8 17596.7 17898.7 13893.0 13989.8 14334.6 14772.6 14846.8 14296.3 14337.1 14426.4 14526.4 14958.3 14236.6 14264.9 14357.9 14626.8 14751.6 9730.9 9737.0 9754.7 9812.9 9863.2 13647.8 13879.3 13899.2 14498.9 14531.6 17:19:41 INFO - PROCESS | 26640 | 17:19:41 INFO - PROCESS | 26640 | [#3] mootools.html Cycles:180 Average:5078.37 Median:6140.43 stddev:2591.29 (42.2%) stddev-sans-first:2581.37 17:19:41 INFO - PROCESS | 26640 | Values: 1109.2 1437.0 1444.6 1584.7 1767.2 6430.4 7163.0 7277.3 7287.7 7288.4 7037.0 7176.0 7191.5 7221.1 7226.7 1913.2 1950.1 1952.3 2153.0 2196.7 2188.3 2220.6 2220.8 2221.4 2222.6 2151.3 2169.6 2242.8 2246.1 2248.5 2162.3 2182.4 2225.9 2256.5 2256.6 2220.8 2230.9 2236.6 2259.8 2262.8 7281.5 7339.3 7350.5 7372.9 7373.2 4424.6 4485.7 4496.0 4511.9 4512.1 2877.9 2902.0 2951.9 2958.9 2975.4 975.6 977.5 991.1 1014.4 1051.7 9892.7 9967.9 9971.9 9974.4 9986.3 3993.9 4025.1 4080.1 4082.8 4114.0 8626.7 8629.4 8641.1 8643.0 8643.2 4497.4 4499.4 4504.3 4509.4 4511.2 4117.2 4123.1 4127.8 4129.9 4130.7 3135.8 3177.6 3298.1 3404.9 3466.9 1114.4 1128.2 1133.4 1136.4 1143.7 902.8 944.2 1000.3 1000.5 1007.1 6641.0 6706.4 6712.5 6713.2 6713.9 1044.1 1066.5 1074.4 1123.3 1155.8 5026.6 5157.4 5191.5 5198.6 5202.9 8626.2 8683.7 8710.5 8713.7 8779.7 8509.2 8518.6 8568.7 8615.1 8686.9 6737.9 6821.3 6830.6 6912.7 6919.6 6459.3 6490.1 6490.4 6510.4 6518.8 7491.7 7492.1 7747.1 7751.0 7758.9 7798.6 7814.9 7911.3 7930.9 7935.4 5976.8 6094.1 6097.4 6098.1 6108.7 6321.9 6453.2 6460.6 6566.8 6910.6 6481.7 6578.9 6625.9 6663.4 6762.3 6371.2 6411.4 6426.7 6472.4 6680.6 6593.9 6621.7 6630.6 6633.0 6634.2 6110.7 6133.2 6147.6 6246.1 6246.2 6021.2 6110.1 6114.9 6126.6 6236.0 17:19:41 INFO - PROCESS | 26640 | 17:19:41 INFO - PROCESS | 26640 | [#4] prototype.html Cycles:180 Average:5284.04 Median:5951.60 stddev:1570.46 (26.4%) stddev-sans-first:1530.16 17:19:41 INFO - PROCESS | 26640 | Values: 327.6 332.9 334.1 337.0 340.0 5893.3 5918.6 5949.2 5954.0 5985.0 5629.9 5703.7 5777.4 5851.0 5887.6 4594.5 4619.4 4624.4 4629.6 4648.8 4380.7 4590.9 4591.4 4598.3 4602.5 4405.0 4414.5 4479.0 4506.8 4548.1 4502.2 4542.1 4543.0 4548.8 4555.6 4023.7 4029.7 4031.9 4033.8 4034.7 5484.4 5617.4 5622.4 5623.7 5631.3 5302.8 5318.4 5319.5 5321.4 5323.0 6217.3 6241.1 6244.8 6249.4 6251.1 4427.9 4448.0 4457.9 4458.4 4464.1 6329.6 6499.6 6510.9 6512.7 6515.4 4580.3 4580.4 4580.7 4584.6 4595.0 4632.5 4634.3 4639.3 4642.5 4643.7 5257.8 5296.7 5298.6 5310.3 5314.0 6110.9 6281.7 6295.4 6307.2 6319.4 1621.3 1621.5 1635.8 1637.6 1641.3 1125.2 1126.1 1126.2 1148.8 1150.3 5970.3 5977.8 5981.6 5983.4 5983.7 6415.8 6435.5 6457.0 6472.1 6472.9 5846.4 5871.7 5947.8 6064.3 6116.0 3481.7 3493.6 3500.9 3503.4 3503.7 6712.8 6778.1 6780.7 6785.1 6787.9 6563.0 6662.9 6686.7 6688.8 6709.9 6722.8 6776.7 6782.1 6784.7 6786.6 6506.8 6514.9 6516.7 6519.3 6523.4 6326.5 6443.9 6450.0 6458.7 6462.1 6701.1 6759.3 6761.6 6766.0 6767.4 4616.2 4618.1 4619.6 4620.0 4622.0 6431.1 6511.6 6534.4 6535.6 6535.7 6333.5 6334.6 6342.3 6345.7 6353.1 6326.0 6328.4 6334.7 6338.7 6344.1 6068.8 6190.1 6212.1 6213.3 6215.7 6347.8 6350.7 6351.6 6358.2 6367.1 6193.8 6202.8 6203.1 6209.9 6219.5 17:19:41 INFO - PROCESS | 26640 | 17:19:41 INFO - PROCESS | 26640 | [#5] yui.html Cycles:180 Average:13516.95 Median:471.90 stddev:15878.93 (3364.9%) stddev-sans-first:15894.93 17:19:41 INFO - PROCESS | 26640 | Values: 838.5 851.5 851.6 856.6 860.2 13682.0 13932.6 13942.9 13961.8 13974.1 13096.5 14255.4 14696.3 14709.1 14718.0 510.3 811.7 825.9 826.2 827.0 513.5 517.5 520.8 813.0 829.9 862.8 868.2 873.9 874.6 875.0 855.1 865.5 866.0 866.1 866.2 468.3 475.5 476.6 625.0 625.5 13343.8 13474.2 13477.9 13481.5 13542.1 11663.9 12095.6 12153.2 12619.7 12847.2 9724.3 10211.9 10257.4 10329.3 10628.4 3576.8 3601.7 3613.7 3662.9 3739.8 48127.5 48264.8 48386.8 48610.3 49085.0 10077.8 10329.5 10378.0 10439.6 10451.2 17893.3 17935.3 17963.1 17989.1 17989.5 7072.2 7144.8 7205.5 7215.2 7363.8 4018.6 4098.5 4149.6 4202.9 4381.1 3056.7 3058.3 3075.2 3077.7 3090.5 561.5 566.3 567.7 572.8 588.6 525.7 558.0 562.7 600.8 609.7 7493.2 7807.6 7920.0 7963.0 8045.7 461.7 511.6 597.9 611.6 625.2 3443.3 3518.1 3536.7 3594.5 3614.9 54439.5 55559.7 55650.4 55852.7 58997.7 49832.3 50598.5 50895.2 51407.7 53311.0 44644.6 44804.6 45250.6 45959.0 46336.5 7773.5 7776.7 8287.6 8316.9 8465.1 35455.8 35658.5 35667.5 37199.0 37308.6 40743.4 41318.6 44182.6 45531.3 46544.3 9835.7 9846.9 9951.9 10078.3 10121.7 10353.7 10355.9 10418.8 11453.2 11599.1 10399.3 10549.4 10663.8 10695.3 11021.4 9738.8 10058.2 10127.4 10355.4 10373.9 7647.4 10170.7 10285.3 10510.6 10579.5 8855.1 8981.2 9037.7 9162.5 9198.1 8436.0 8618.7 8786.8 8904.2 8906.3 17:19:41 INFO - PROCESS | 26640 | -------- Summary: end -------- 17:19:41 INFO - PROCESS | 26640 | 17:19:42 INFO - TEST-INFO | 26640: exit 0 17:19:42 INFO - TEST-OK | dromaeo_css | took 1112947ms 17:19:42 INFO - TEST-START | kraken 17:19:42 INFO - operating with platform_type : linux_ 17:19:42 INFO - Initialising browser for kraken test... 17:19:42 INFO - TEST-INFO | started process 26836 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpNgkWPF/profile http://localhost:58755/getInfo.html) 17:19:46 INFO - PROCESS | 26836 | __metrics Screen width/height:1600/1200 17:19:46 INFO - PROCESS | 26836 | colorDepth:24 17:19:46 INFO - PROCESS | 26836 | Browser inner width/height: 1024/697 17:19:46 INFO - PROCESS | 26836 | __metrics 17:19:46 INFO - PROCESS | 26836 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:19:46 INFO - PROCESS | 26836 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:19:47 INFO - TEST-INFO | 26836: exit 0 17:19:47 INFO - Browser initialized. 17:19:47 INFO - Running cycle 1/1 for kraken test... 17:19:47 INFO - TEST-INFO | started process 26920 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpNgkWPF/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:19:59 INFO - PROCESS | 26920 | RSS: Main: 149700608 17:19:59 INFO - PROCESS | 26920 | 17:20:01 INFO - PROCESS | 26920 | Cycle 1(1): loaded http://localhost:58755/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58755/tests/kraken/driver.html?testName=audio-beat-detection) 17:20:02 INFO - PROCESS | 26920 | RSS: Main: 184139776 17:20:02 INFO - PROCESS | 26920 | 17:20:04 INFO - PROCESS | 26920 | Cycle 1(1): loaded http://localhost:58755/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58755/tests/kraken/driver.html?testName=audio-dft) 17:20:05 INFO - PROCESS | 26920 | RSS: Main: 174845952 17:20:05 INFO - PROCESS | 26920 | 17:20:08 INFO - PROCESS | 26920 | Cycle 1(1): loaded http://localhost:58755/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58755/tests/kraken/driver.html?testName=audio-fft) 17:20:08 INFO - PROCESS | 26920 | RSS: Main: 159207424 17:20:08 INFO - PROCESS | 26920 | 17:20:10 INFO - PROCESS | 26920 | Cycle 1(1): loaded http://localhost:58755/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58755/tests/kraken/driver.html?testName=audio-oscillator) 17:20:11 INFO - PROCESS | 26920 | RSS: Main: 161468416 17:20:11 INFO - PROCESS | 26920 | 17:20:13 INFO - PROCESS | 26920 | Cycle 1(1): loaded http://localhost:58755/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58755/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:20:14 INFO - PROCESS | 26920 | RSS: Main: 164786176 17:20:14 INFO - PROCESS | 26920 | 17:20:17 INFO - PROCESS | 26920 | Cycle 1(1): loaded http://localhost:58755/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58755/tests/kraken/driver.html?testName=imaging-darkroom) 17:20:17 INFO - PROCESS | 26920 | RSS: Main: 163569664 17:20:17 INFO - PROCESS | 26920 | 17:20:20 INFO - PROCESS | 26920 | Cycle 1(1): loaded http://localhost:58755/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58755/tests/kraken/driver.html?testName=imaging-desaturate) 17:20:21 INFO - PROCESS | 26920 | RSS: Main: 164118528 17:20:21 INFO - PROCESS | 26920 | 17:20:24 INFO - PROCESS | 26920 | Cycle 1(1): loaded http://localhost:58755/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58755/tests/kraken/driver.html?testName=json-parse-financial) 17:20:24 INFO - PROCESS | 26920 | RSS: Main: 165351424 17:20:24 INFO - PROCESS | 26920 | 17:20:26 INFO - PROCESS | 26920 | Cycle 1(1): loaded http://localhost:58755/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58755/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:20:26 INFO - PROCESS | 26920 | RSS: Main: 175771648 17:20:26 INFO - PROCESS | 26920 | 17:20:28 INFO - PROCESS | 26920 | Cycle 1(1): loaded http://localhost:58755/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58755/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:20:29 INFO - PROCESS | 26920 | RSS: Main: 175067136 17:20:29 INFO - PROCESS | 26920 | 17:20:31 INFO - PROCESS | 26920 | Cycle 1(1): loaded http://localhost:58755/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58755/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:20:31 INFO - PROCESS | 26920 | RSS: Main: 189820928 17:20:31 INFO - PROCESS | 26920 | 17:20:34 INFO - PROCESS | 26920 | Cycle 1(1): loaded http://localhost:58755/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58755/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:20:34 INFO - PROCESS | 26920 | RSS: Main: 196431872 17:20:34 INFO - PROCESS | 26920 | 17:20:37 INFO - PROCESS | 26920 | Cycle 1(1): loaded http://localhost:58755/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58755/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:20:38 INFO - PROCESS | 26920 | RSS: Main: 191516672 17:20:38 INFO - PROCESS | 26920 | 17:20:39 INFO - PROCESS | 26920 | Cycle 1(1): loaded http://localhost:58755/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58755/tests/kraken/driver.html?testName=ai-astar) 17:20:39 INFO - PROCESS | 26920 | RSS: Main: 250949632 17:20:39 INFO - PROCESS | 26920 | 17:20:39 INFO - PROCESS | 26920 | __start_tp_report 17:20:39 INFO - PROCESS | 26920 | _x_x_mozilla_page_load 17:20:39 INFO - PROCESS | 26920 | _x_x_mozilla_page_load_details 17:20:39 INFO - PROCESS | 26920 | |i|pagename|runs| 17:20:39 INFO - PROCESS | 26920 | |0;ai-astar;109;110;104;112;114;110;101;109;110;102 17:20:39 INFO - PROCESS | 26920 | |1;audio-beat-detection;151;132;155;161;129;160;158;129;173;124 17:20:39 INFO - PROCESS | 26920 | |2;audio-dft;161;160;160;161;162;162;161;161;162;160 17:20:39 INFO - PROCESS | 26920 | |3;audio-fft;74;73;86;95;73;74;72;98;90;73 17:20:39 INFO - PROCESS | 26920 | |4;audio-oscillator;96;96;138;96;97;97;142;97;96;141 17:20:39 INFO - PROCESS | 26920 | |5;imaging-gaussian-blur;109;109;108;109;109;109;109;109;109;110 17:20:39 INFO - PROCESS | 26920 | |6;imaging-darkroom;145;145;145;145;145;146;145;144;146;145 17:20:39 INFO - PROCESS | 26920 | |7;imaging-desaturate;95;96;95;96;96;95;96;96;96;96 17:20:39 INFO - PROCESS | 26920 | |8;json-parse-financial;57;55;57;55;55;56;55;65;54;54 17:20:39 INFO - PROCESS | 26920 | |9;json-stringify-tinderbox;68;69;68;68;69;70;68;68;74;69 17:20:39 INFO - PROCESS | 26920 | |10;stanford-crypto-aes;86;85;86;84;85;85;85;85;86;86 17:20:39 INFO - PROCESS | 26920 | |11;stanford-crypto-ccm;122;119;118;112;124;115;115;118;126;114 17:20:39 INFO - PROCESS | 26920 | |12;stanford-crypto-pbkdf2;140;152;150;150;150;143;151;151;151;149 17:20:39 INFO - PROCESS | 26920 | |13;stanford-crypto-sha256-iterative;70;70;71;67;67;67;67;68;70;66 17:20:39 INFO - PROCESS | 26920 | __end_tp_report 17:20:39 INFO - PROCESS | 26920 | __start_cc_report 17:20:39 INFO - PROCESS | 26920 | _x_x_mozilla_cycle_collect,916 17:20:39 INFO - PROCESS | 26920 | __end_cc_report 17:20:39 INFO - PROCESS | 26920 | __startTimestamp1451524839948__endTimestamp 17:20:39 INFO - PROCESS | 26920 | 17:20:39 INFO - PROCESS | 26920 | ------- Summary: start ------- 17:20:39 INFO - PROCESS | 26920 | Number of tests: 14 17:20:39 INFO - PROCESS | 26920 | 17:20:39 INFO - PROCESS | 26920 | [#0] ai-astar Cycles:10 Average:108.10 Median:110.00 stddev:4.31 (3.9%) stddev-sans-first:4.56 17:20:39 INFO - PROCESS | 26920 | Values: 109.0 110.0 104.0 112.0 114.0 110.0 101.0 109.0 110.0 102.0 17:20:39 INFO - PROCESS | 26920 | 17:20:39 INFO - PROCESS | 26920 | [#1] audio-beat-detection Cycles:10 Average:147.20 Median:156.50 stddev:17.14 (11.0%) stddev-sans-first:18.12 17:20:39 INFO - PROCESS | 26920 | Values: 151.0 132.0 155.0 161.0 129.0 160.0 158.0 129.0 173.0 124.0 17:20:39 INFO - PROCESS | 26920 | 17:20:39 INFO - PROCESS | 26920 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 17:20:39 INFO - PROCESS | 26920 | Values: 161.0 160.0 160.0 161.0 162.0 162.0 161.0 161.0 162.0 160.0 17:20:39 INFO - PROCESS | 26920 | 17:20:39 INFO - PROCESS | 26920 | [#3] audio-fft Cycles:10 Average:80.80 Median:80.00 stddev:10.34 (12.9%) stddev-sans-first:10.67 17:20:39 INFO - PROCESS | 26920 | Values: 74.0 73.0 86.0 95.0 73.0 74.0 72.0 98.0 90.0 73.0 17:20:39 INFO - PROCESS | 26920 | 17:20:39 INFO - PROCESS | 26920 | [#4] audio-oscillator Cycles:10 Average:109.60 Median:96.00 stddev:21.24 (22.1%) stddev-sans-first:21.95 17:20:39 INFO - PROCESS | 26920 | Values: 96.0 96.0 138.0 96.0 97.0 97.0 142.0 97.0 96.0 141.0 17:20:39 INFO - PROCESS | 26920 | 17:20:39 INFO - PROCESS | 26920 | [#5] imaging-gaussian-blur Cycles:10 Average:109.00 Median:109.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 17:20:39 INFO - PROCESS | 26920 | Values: 109.0 109.0 108.0 109.0 109.0 109.0 109.0 109.0 109.0 110.0 17:20:39 INFO - PROCESS | 26920 | 17:20:39 INFO - PROCESS | 26920 | [#6] imaging-darkroom Cycles:10 Average:145.10 Median:145.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 17:20:39 INFO - PROCESS | 26920 | Values: 145.0 145.0 145.0 145.0 145.0 146.0 145.0 144.0 146.0 145.0 17:20:39 INFO - PROCESS | 26920 | 17:20:39 INFO - PROCESS | 26920 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 17:20:39 INFO - PROCESS | 26920 | Values: 95.0 96.0 95.0 96.0 96.0 95.0 96.0 96.0 96.0 96.0 17:20:39 INFO - PROCESS | 26920 | 17:20:39 INFO - PROCESS | 26920 | [#8] json-parse-financial Cycles:10 Average:56.30 Median:55.50 stddev:3.23 (5.8%) stddev-sans-first:3.42 17:20:39 INFO - PROCESS | 26920 | Values: 57.0 55.0 57.0 55.0 55.0 56.0 55.0 65.0 54.0 54.0 17:20:39 INFO - PROCESS | 26920 | 17:20:39 INFO - PROCESS | 26920 | [#9] json-stringify-tinderbox Cycles:10 Average:69.10 Median:69.00 stddev:1.85 (2.7%) stddev-sans-first:1.92 17:20:39 INFO - PROCESS | 26920 | Values: 68.0 69.0 68.0 68.0 69.0 70.0 68.0 68.0 74.0 69.0 17:20:39 INFO - PROCESS | 26920 | 17:20:39 INFO - PROCESS | 26920 | [#10] stanford-crypto-aes Cycles:10 Average:85.30 Median:85.50 stddev:0.67 (0.8%) stddev-sans-first:0.67 17:20:39 INFO - PROCESS | 26920 | Values: 86.0 85.0 86.0 84.0 85.0 85.0 85.0 85.0 86.0 86.0 17:20:39 INFO - PROCESS | 26920 | 17:20:39 INFO - PROCESS | 26920 | [#11] stanford-crypto-ccm Cycles:10 Average:118.30 Median:118.50 stddev:4.55 (3.8%) stddev-sans-first:4.62 17:20:39 INFO - PROCESS | 26920 | Values: 122.0 119.0 118.0 112.0 124.0 115.0 115.0 118.0 126.0 114.0 17:20:39 INFO - PROCESS | 26920 | 17:20:39 INFO - PROCESS | 26920 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.70 Median:150.50 stddev:3.95 (2.6%) stddev-sans-first:2.65 17:20:39 INFO - PROCESS | 26920 | Values: 140.0 152.0 150.0 150.0 150.0 143.0 151.0 151.0 151.0 149.0 17:20:39 INFO - PROCESS | 26920 | 17:20:39 INFO - PROCESS | 26920 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:69.00 stddev:1.77 (2.6%) stddev-sans-first:1.76 17:20:39 INFO - PROCESS | 26920 | Values: 70.0 70.0 71.0 67.0 67.0 67.0 67.0 68.0 70.0 66.0 17:20:39 INFO - PROCESS | 26920 | -------- Summary: end -------- 17:20:39 INFO - PROCESS | 26920 | 17:20:40 INFO - TEST-INFO | 26920: exit 0 17:20:40 INFO - TEST-OK | kraken | took 58651ms 17:20:40 INFO - TEST-START | v8_7 17:20:40 INFO - operating with platform_type : linux_ 17:20:40 INFO - Initialising browser for v8_7 test... 17:20:40 INFO - TEST-INFO | started process 27169 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmptReLTw/profile http://localhost:58755/getInfo.html) 17:20:44 INFO - PROCESS | 27169 | __metrics Screen width/height:1600/1200 17:20:44 INFO - PROCESS | 27169 | colorDepth:24 17:20:44 INFO - PROCESS | 27169 | Browser inner width/height: 1024/697 17:20:44 INFO - PROCESS | 27169 | __metrics 17:20:44 INFO - PROCESS | 27169 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:20:44 INFO - PROCESS | 27169 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:20:45 INFO - TEST-INFO | 27169: exit 0 17:20:45 INFO - Browser initialized. 17:20:45 INFO - Running cycle 1/1 for v8_7 test... 17:20:45 INFO - TEST-INFO | started process 27250 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmptReLTw/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:20:57 INFO - PROCESS | 27250 | RSS: Main: 149651456 17:20:57 INFO - PROCESS | 27250 | 17:21:19 INFO - PROCESS | 27250 | Cycle 1(1): loaded http://localhost:58755/tests/v8_7/run.html (next: http://localhost:58755/tests/v8_7/run.html) 17:21:19 INFO - PROCESS | 27250 | RSS: Main: 611033088 17:21:19 INFO - PROCESS | 27250 | 17:21:19 INFO - PROCESS | 27250 | __start_tp_report 17:21:19 INFO - PROCESS | 27250 | _x_x_mozilla_page_load 17:21:19 INFO - PROCESS | 27250 | _x_x_mozilla_page_load_details 17:21:19 INFO - PROCESS | 27250 | |i|pagename|runs| 17:21:19 INFO - PROCESS | 27250 | |0;Richards;169.34801016088062 17:21:19 INFO - PROCESS | 27250 | |1;DeltaBlue;197.1608832807571 17:21:19 INFO - PROCESS | 27250 | |2;Encrypt;284.4950213371266 17:21:19 INFO - PROCESS | 27250 | |3;Decrypt;5240.837696335078 17:21:19 INFO - PROCESS | 27250 | |4;RayTrace;1103.7527593818984 17:21:19 INFO - PROCESS | 27250 | |5;Earley;800.640512409928 17:21:19 INFO - PROCESS | 27250 | |6;Boyer;12575 17:21:19 INFO - PROCESS | 27250 | |7;RegExp;25641.02564102564 17:21:19 INFO - PROCESS | 27250 | |8;Splay;670.911528150134 17:21:19 INFO - PROCESS | 27250 | |9;NavierStokes;4835.748792270531 17:21:19 INFO - PROCESS | 27250 | __end_tp_report 17:21:19 INFO - PROCESS | 27250 | __startTimestamp1451524879323__endTimestamp 17:21:19 INFO - PROCESS | 27250 | 17:21:19 INFO - PROCESS | 27250 | ------- Summary: start ------- 17:21:19 INFO - PROCESS | 27250 | Number of tests: 10 17:21:19 INFO - PROCESS | 27250 | 17:21:19 INFO - PROCESS | 27250 | [#0] Richards Cycles:1 Average:169.35 Median:169.35 stddev:0.00 (0.0%) 17:21:19 INFO - PROCESS | 27250 | Values: 169.3 17:21:19 INFO - PROCESS | 27250 | 17:21:19 INFO - PROCESS | 27250 | [#1] DeltaBlue Cycles:1 Average:197.16 Median:197.16 stddev:0.00 (0.0%) 17:21:19 INFO - PROCESS | 27250 | Values: 197.2 17:21:19 INFO - PROCESS | 27250 | 17:21:19 INFO - PROCESS | 27250 | [#2] Encrypt Cycles:1 Average:284.50 Median:284.50 stddev:0.00 (0.0%) 17:21:19 INFO - PROCESS | 27250 | Values: 284.5 17:21:19 INFO - PROCESS | 27250 | 17:21:19 INFO - PROCESS | 27250 | [#3] Decrypt Cycles:1 Average:5240.84 Median:5240.84 stddev:0.00 (0.0%) 17:21:19 INFO - PROCESS | 27250 | Values: 5240.8 17:21:19 INFO - PROCESS | 27250 | 17:21:19 INFO - PROCESS | 27250 | [#4] RayTrace Cycles:1 Average:1103.75 Median:1103.75 stddev:0.00 (0.0%) 17:21:19 INFO - PROCESS | 27250 | Values: 1103.8 17:21:19 INFO - PROCESS | 27250 | 17:21:19 INFO - PROCESS | 27250 | [#5] Earley Cycles:1 Average:800.64 Median:800.64 stddev:0.00 (0.0%) 17:21:19 INFO - PROCESS | 27250 | Values: 800.6 17:21:19 INFO - PROCESS | 27250 | 17:21:19 INFO - PROCESS | 27250 | [#6] Boyer Cycles:1 Average:12575.00 Median:12575.00 stddev:0.00 (0.0%) 17:21:19 INFO - PROCESS | 27250 | Values: 12575.0 17:21:19 INFO - PROCESS | 27250 | 17:21:19 INFO - PROCESS | 27250 | [#7] RegExp Cycles:1 Average:25641.03 Median:25641.03 stddev:0.00 (0.0%) 17:21:19 INFO - PROCESS | 27250 | Values: 25641.0 17:21:19 INFO - PROCESS | 27250 | 17:21:19 INFO - PROCESS | 27250 | [#8] Splay Cycles:1 Average:670.91 Median:670.91 stddev:0.00 (0.0%) 17:21:19 INFO - PROCESS | 27250 | Values: 670.9 17:21:19 INFO - PROCESS | 27250 | 17:21:19 INFO - PROCESS | 27250 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 17:21:19 INFO - PROCESS | 27250 | Values: 4835.7 17:21:19 INFO - PROCESS | 27250 | -------- Summary: end -------- 17:21:19 INFO - PROCESS | 27250 | 17:21:20 INFO - TEST-INFO | 27250: exit 0 17:21:20 INFO - TEST-OK | v8_7 | took 39335ms 17:21:20 INFO - SUITE-END | took 1210s 17:21:20 INFO - Completed test suite (00:20:11) 17:21:20 INFO - Working with test: dromaeo_css 17:21:20 INFO - Generating results file: dromaeo_css 17:21:20 INFO - Working with test: kraken 17:21:20 INFO - Generating results file: kraken 17:21:20 INFO - javascript benchmark 17:21:20 INFO - Working with test: v8_7 17:21:20 INFO - Generating results file: v8_7 17:21:20 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:21:20 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 17:21:20 INFO - process_Request line: dromaeo_css 6815.48 graph.html#tests=[[72,201,35]] 17:21:20 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:21:20 INFO - process_Request line: kraken 1502.50 graph.html#tests=[[232,201,35]] 17:21:20 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:21:20 INFO - process_Request line: v8_7 20567.91 graph.html#tests=[[230,201,35]] 17:21:20 INFO - RETURN: dromaeo_css: 6815.48 17:21:20 INFO - RETURN: kraken: 1502.50 17:21:20 INFO - RETURN: v8_7: 20567.91 17:21:20 INFO - javascript benchmark 17:21:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3137.654857965624, 3220.0, 3224.854881530331, 3228.3220523690024, 3259.804411735296, 5216.452272511388, 5332.466753324676, 5343.599230057746, 5381.408045115039, 5443.836684899449, 5292.894142117156, 5309.123994540906, 5406.053940560406, 5421.241026256327, 5428.212909128174, 4880.682755620891, 4905.852824415273, 4922.384701912261, 4935.333729946447, 4946.950530494703, 4859.076775412678, 4939.20972644377, 4961.082199793032, 4994.650374473788, 5017.222330538754, 4828.348172996635, 4838.201696720037, 4927.137750893579, 4940.110780059588, 4953.90092198154, 4814.807407703687, 4822.590079843218, 4824.903501929942, 4847.660663753539, 4859.319695242669, 4781.95218047822, 4819.253015782524, 4840.225563909793, 4842.83050093245, 4862.44081930579, 5080.542751152377, 5179.378474583036, 5187.974060129713, 5198.0, 5238.92141617876, 5767.711614419262, 5774.249347584787, 5777.913331300034, 5781.219535362757, 5781.739821707991, 5616.943830561683, 5796.159556864273, 5797.072468405077, 5797.101449275369, 5813.854653633651, 5262.210668399733, 5307.6019298552765, 5316.41519432866, 5322.7338633068575, 5362.973185134088, 5760.855978600484, 5828.0966450200285, 5829.387914269026, 5831.912521312183, 5853.297604287428, 5446.455354464601, 5555.8888822223325, 5559.861003474945, 5629.915551266734, 5644.435556444323, 5655.604107712421, 5725.6850873202375, 5728.856778580569, 5729.512991395694, 5780.42195780427, 5660.745266463019, 5672.829815105553, 5686.2323586315315, 5691.68695721731, 5691.9715401423555, 5579.442055794388, 5701.971490142523, 5709.058005429058, 5728.914066289009, 5729.742161602738, 4374.168907907488, 4433.1577000369825, 4440.866773996785, 4471.038726673781, 4477.664175186874, 3909.8240579173435, 3937.586553411908, 3963.980180099081, 3982.6216509431556, 3983.940240896389, 5243.134882744381, 5352.4915133062295, 5353.116735738559, 5353.277307563507, 5355.919661205085, 5750.827475175752, 5802.071668533014, 5809.331926828469, 5810.883782324415, 5877.0009098453365, 5290.1800220965815, 5317.069512835238, 5322.2548843161985, 5327.334083239595, 5332.653377530448, 4828.324034635154, 4928.531789479994, 4932.062908047459, 4937.876553086202, 4986.800527978913, 5995.970020149872, 6003.159557661931, 6003.6097653651495, 6008.699565021731, 6009.819705408845, 5779.653220806765, 5782.85542861415, 5783.710814459176, 5784.4504772046585, 5786.276715410574, 5711.286089238845, 5829.38791426911, 5901.1443340714495, 5901.734421950937, 5963.0, 5627.155926611041, 5651.039323314964, 5652.4064973178865, 5662.85842853932, 5697.401772813795, 5659.603827732019, 5707.714614269353, 5707.9429205709075, 5712.228849105318, 5712.257406537124, 5452.91820622683, 5508.614396992172, 5571.9721401392735, 5589.077802162597, 5633.239512665901, 5538.889222215453, 5548.778048878, 5555.0834112371, 5565.1930470082425, 5597.944020559742, 5474.2609747683555, 5474.835754927359, 5477.20580515815, 5477.20580515831, 5481.753321100639, 5480.753366098455, 5482.369527504388, 5540.750666219949, 5603.299587551556, 5605.32736071674, 5424.050791111618, 5429.592780541396, 5431.8098866539485, 5450.918236226539, 5467.863303417287], "unit": "score", "name": "dojo.html", "value": 5272.992977857158}, {"lowerIsBetter": false, "replicates": [498.60111910471636, 529.3277537527342, 553.0101118996994, 558.4276116980095, 570.7060863655219, 25655.74344256557, 25909.74090259097, 36827.447588286195, 37561.43657845134, 37562.624373756254, 39632.80183599085, 40004.59995400052, 40029.0, 40110.7994460028, 40131.398029029515, 7225.277472252786, 8446.0, 8671.219590236877, 8676.219140277373, 8678.826423471526, 7272.345488905998, 10102.444365559892, 10377.740556486073, 10382.428966406844, 10391.792164156712, 10062.597496100147, 10165.949170254175, 10169.745756356113, 10170.084692377684, 10177.23670724695, 7457.254274572553, 7510.737124200627, 9975.850362244571, 10063.547140378663, 10200.234982376278, 9889.604415823358, 9961.053699898497, 9964.352317099365, 10014.849777253346, 10023.799524009552, 37078.0, 37662.81168594139, 37678.811605941795, 37691.81154094212, 37693.24613507742, 2981.791274610778, 3007.8646460909313, 3058.29659178388, 3096.2259435141214, 3098.2564184595535, 28824.855875720696, 29706.554401683992, 30080.548791768142, 30240.84879575588, 30295.242618934484, 3837.0, 3933.5465283209455, 3933.8623148189677, 3988.7008474364247, 4043.2722110020186, 255069.0, 256411.0, 256561.0, 256634.99999999814, 257062.0, 44224.77887610606, 45163.0, 58998.70500647555, 59355.703221483614, 59380.406195938354, 63881.0, 64680.676596616715, 65440.0, 65476.34523654702, 65534.344656553774, 15633.452829151152, 15645.843541564665, 15711.057336559843, 15858.207089645472, 15860.762088568681, 12031.87968120325, 12153.270803751626, 12162.5134994601, 12171.939140304241, 12173.208741431956, 19435.514112147026, 19677.606447871247, 19730.0, 20320.28878989228, 20400.489987750425, 7604.163542010375, 7754.689812407553, 7874.803129921684, 7895.289423951872, 7927.682892684344, 964.5129209749032, 966.2415004221652, 982.5627595719836, 985.4186030242191, 1075.961696962435, 28378.0, 28657.28356791097, 29084.272893177418, 29108.417831643674, 29726.702732972826, 958.942463452195, 974.0454354732402, 976.770458942148, 1065.6856227412932, 1093.294824837991, 13808.0, 13897.583072507841, 14145.646358841112, 14149.0, 14203.218822964629, 251145.0, 253823.0, 254651.0, 254927.0, 254967.0, 48462.75768621205, 48958.5104148954, 49099.263511047364, 49115.50884491109, 49234.26148607774, 1341.3025226881966, 1356.6472717093627, 1365.863413658626, 1382.6958069224754, 1385.528920167148, 23462.0, 26490.0, 26842.731572684024, 28458.146255612366, 29468.263293417836, 43526.347104794084, 43984.12031759411, 44097.338539922566, 44116.77941610271, 44125.0, 237753.0, 241878.95302617576, 241896.0, 242773.0, 296550.0, 23738.406539836644, 32129.0, 32357.0, 32683.097535369885, 32837.50743738894, 37938.0, 38460.61539384571, 38769.0, 38811.22377552489, 39630.40554391744, 32479.35041299208, 32709.182270442478, 32809.343813124084, 33076.503852441754, 33352.83323583366, 32431.547131604973, 34775.65224347724, 35400.46899296564, 35423.64576354306, 35452.64547354596, 35960.82019589885, 36097.458538122475, 36476.27047459089, 36882.89351319465, 37180.62819371772, 27311.45377092487, 27819.721802781714, 31106.37787244197, 31788.0, 32182.67817321797, 23290.0, 23336.299911002698, 23396.883015585496, 23611.29166125019, 23687.289381318587], "unit": "score", "name": "ext.html", "value": 17939.287601374253}, {"lowerIsBetter": false, "replicates": [344.88618755810575, 347.61588444768546, 350.3640891781417, 352.8976596786932, 358.16368778901267, 16198.919005404987, 16339.754903676454, 16498.34006639733, 16872.66254674906, 16876.66246675066, 15663.0, 16020.0, 16021.519354419357, 16132.516024519255, 16185.595360116004, 5367.382750983647, 5519.972400137994, 5520.199571062193, 5527.060399732055, 5533.280673512438, 5300.178472336794, 5517.972410137943, 5518.0, 5519.779208831642, 5520.392756796749, 3734.757240779354, 3853.7109716771215, 3858.2862170498406, 5493.725313734317, 5506.779728810843, 3845.8846234612865, 3991.840326386941, 6039.305479869828, 6039.849003774941, 6041.848953776125, 5148.150555158394, 5377.4084850666395, 5387.299651045339, 5388.245645609618, 5391.029614669358, 10910.781784364348, 11148.331100134017, 12756.0, 12959.416826242747, 12960.0279979001, 2156.4177672028463, 2162.859414138076, 2188.124750099957, 2193.462601662587, 2211.8783466909313, 9494.572744226458, 9740.074692904163, 10258.538365773484, 10428.84356734642, 13011.674708132277, 1844.1056087797408, 1847.4734700610395, 1864.869459137861, 1878.605492846504, 1907.8569107317007, 59385.703071484364, 59855.80288394251, 60595.697021514614, 61318.0, 62317.37682623161, 10205.642802501878, 10443.738906527245, 10453.268271221094, 10459.686209413578, 10524.052835244865, 13517.59447216585, 13539.390727417092, 13547.86452135466, 13600.523981660594, 13644.522441714493, 7374.188839227681, 7506.061742282215, 7560.395168386516, 7704.768856934301, 7844.137144914055, 7261.3101755333155, 7272.672729727175, 7276.527025743309, 7318.451116166309, 7452.105747310357, 4411.625011874026, 4473.955260447419, 4503.842365517191, 4533.093381323749, 4540.545945405499, 1720.2688857235626, 1726.3008481564987, 1726.413019573326, 1772.53027947594, 1838.5955089880206, 914.5610107148473, 1010.9191264698807, 1042.7393151712072, 1059.2532264753331, 1068.4497483795851, 16189.0, 16777.496675099766, 16954.321827127023, 17054.488365349058, 17340.30638774435, 808.9150639182918, 921.4425272710048, 923.3702515060922, 951.205743204432, 1011.3780025284544, 9637.614495420105, 9684.46735429558, 9901.801963960825, 10106.14097801695, 10168.186545076376, 521389.0, 522126.0, 525517.0, 553753.0, 559270.0, 58132.0, 75523.24476755272, 79071.0, 79466.0, 83214.58392707998, 1169.976600468003, 1175.400545721688, 1212.5816593275483, 1223.1071317937956, 1249.188027781931, 15702.0, 15778.447754329003, 15886.52340429789, 15992.92003539975, 16143.19284035817, 18685.71971420457, 23495.765042349358, 24923.878425470535, 35792.82103589465, 36126.63873361233, 45498.772506137255, 46297.305540416244, 46750.064998700516, 48991.51008490012, 49163.0, 9766.121049105615, 9840.3603765755, 9907.405555666683, 9919.206463483048, 9952.502374881082, 17032.744508832624, 17229.74155387645, 17397.826021740126, 17596.73604895953, 17898.731519026966, 13893.0, 13989.790153147507, 14334.569962901129, 14772.63068423298, 14846.777298340317, 14296.285185740879, 14337.139771613736, 14426.42294308216, 14526.418943242152, 14958.252087395369, 14236.644083897985, 14264.928675356558, 14357.85642143607, 14626.780598290821, 14751.557453276419, 9730.902690973, 9737.0, 9754.707358779247, 9812.901870981199, 9863.210943124677, 13647.79528307096, 13879.306034698022, 13899.235542045284, 14498.927505362828, 14531.564053078424], "unit": "score", "name": "jquery.html", "value": 8741.322118310029}, {"lowerIsBetter": false, "replicates": [1109.1681239070697, 1436.9640758981027, 1444.6243976566093, 1584.6989072076306, 1767.2400867626923, 6430.356964303567, 7163.0, 7277.2722727727205, 7287.744928927488, 7288.3804876585555, 7036.964815175917, 7175.964120179405, 7191.532550384234, 7221.061262035928, 7226.674799634016, 1913.2155816115396, 1950.0834607734341, 1952.2678995376734, 2152.956940861182, 2196.6814811852273, 2188.2559929624003, 2220.5669894370603, 2220.844540882139, 2221.4002219400754, 2222.633265511197, 2151.2900742754855, 2169.5877783221135, 2242.7532971373134, 2246.05665620439, 2248.4603695113137, 2162.318869556085, 2182.3562049195366, 2225.888705564715, 2256.458449972003, 2256.5938131136472, 2220.837798101127, 2230.944226394337, 2236.630955892276, 2259.751427342991, 2262.8416010879246, 7281.526700764433, 7339.266073392671, 7350.522216055992, 7372.889406658905, 7373.225811289844, 4424.601785839258, 4485.730856148642, 4496.033352829158, 4511.8646440606835, 4512.075024619945, 2877.9280517987218, 2901.9854900725363, 2951.852407379644, 2958.8668509917106, 2975.3751712140474, 975.6048800235916, 977.4721650308825, 991.122856272197, 1014.3812274512542, 1051.7423231308303, 9892.653757118467, 9967.90032099677, 9971.850422243671, 9974.351667141613, 9986.251031172691, 3993.940090898639, 4025.054112283611, 4080.0819815541267, 4082.795860207037, 4113.9794301028305, 8626.698065567674, 8629.43908645936, 8641.135886411434, 8642.95678521616, 8643.222110010129, 4497.392851964943, 4499.370088187657, 4504.25679762842, 4509.368688383629, 4511.233090374644, 4117.197146556393, 4123.072308730511, 4127.834886604503, 4129.8967525811495, 4130.669546436278, 3135.7961732487315, 3177.586913701204, 3298.1259966109, 3404.9148771280916, 3466.9479957800654, 1114.359243435028, 1128.1707944660668, 1133.444612140062, 1136.3920302638048, 1143.651186388143, 902.801383695599, 944.2021491839384, 1000.3397757480028, 1000.5397517142051, 1007.0734923870057, 6640.966795165993, 6706.429953454011, 6712.463002959751, 6713.2279787824045, 6713.899291510631, 1044.1229367331325, 1066.4544369279622, 1074.3607553505651, 1123.2586492914636, 1155.7861795567846, 5026.623003274769, 5157.406898206679, 5191.532762051434, 5198.584113270929, 5202.869928251748, 8626.18051285127, 8683.739487815375, 8710.477371357612, 8713.695020674246, 8779.736607901774, 8509.191626795444, 8518.616662250213, 8568.657253709907, 8615.13848615146, 8686.86969695455, 6737.9326206737305, 6821.283765204681, 6830.556013859084, 6912.688928998207, 6919.550229235084, 6459.321771213955, 6490.091387205701, 6490.448311893542, 6510.44661203803, 6518.804435866931, 7491.662875170739, 7492.063492063492, 7747.147813740371, 7750.99237099196, 7758.92241077582, 7798.649060792164, 7814.882776758467, 7911.28798408146, 7930.881036784568, 7935.404844636791, 5976.760929562769, 6094.08588711679, 6097.420745029215, 6098.146259523759, 6108.72510737009, 6321.8735625288155, 6453.16108905858, 6460.580062295936, 6566.80299591013, 6910.585364878123, 6481.708323125565, 6578.934210657832, 6625.867482650417, 6663.400293973566, 6762.289959554176, 6371.235451745635, 6411.358864113738, 6426.742930282736, 6472.417482426604, 6680.63256520896, 6593.87904056302, 6621.702023409054, 6630.602163870183, 6632.966835165793, 6634.237062737847, 6110.69446527663, 6133.233345831771, 6147.631142131308, 6246.094316324198, 6246.219222597176, 6021.217241758543, 6110.1445797587485, 6114.908276375947, 6126.632402055891, 6236.0], "unit": "score", "name": "mootools.html", "value": 4199.04885204478}, {"lowerIsBetter": false, "replicates": [327.6101439287248, 332.8651895982125, 334.07294757049186, 336.9561956945598, 340.00717903721124, 5893.263342082239, 5918.556108291879, 5949.196858424117, 5954.0, 5985.0, 5629.8592535186535, 5703.7148142592805, 5777.364489906107, 5851.0, 5887.558433117522, 4594.540545945404, 4619.445666520022, 4624.445066592014, 4629.560191781792, 4648.837290694826, 4380.693351465398, 4590.885227869297, 4591.403117594725, 4598.333241679954, 4602.539746025387, 4404.955950440487, 4414.4923333816705, 4479.037007043485, 4506.77466126694, 4548.135854187711, 4502.212112880233, 4542.068875880453, 4543.023250001249, 4548.795304211319, 4555.589996900295, 4023.7384570002855, 4029.6977726670616, 4031.8992025199314, 4033.8184781684895, 4034.6570541504007, 5484.424135465799, 5617.410171931929, 5622.353429355636, 5623.690697011662, 5631.2960879890015, 5302.761375738101, 5318.388385335697, 5319.5478384337375, 5321.388040375367, 5323.0, 6217.2539295284405, 6241.095041218998, 6244.750209991595, 6249.375062493759, 6251.12484252205, 4427.911441771146, 4447.955520444819, 4457.888552786174, 4458.4426946631675, 4464.084862603158, 6329.556931014831, 6499.610023398611, 6510.9023364649565, 6512.674366281714, 6515.413612774825, 4580.267157254823, 4580.358749775034, 4580.725156490621, 4584.633229341644, 4594.97702511492, 4632.536746325341, 4634.304854271819, 4639.327297541838, 4642.489326174185, 4643.6517261205545, 5257.78968841242, 5296.708681022581, 5298.602604804578, 5310.283111779938, 5314.043472175045, 6110.877782444326, 6281.7173227204885, 6295.433410993032, 6307.24313082433, 6319.368063193736, 1621.3271492330787, 1621.5216511129245, 1635.803703555581, 1637.5742307000266, 1641.3352592200179, 1125.201107213871, 1126.1328776841785, 1126.1553834624033, 1148.7530181011123, 1150.2810743285447, 5970.34326224115, 5977.760889564455, 5981.581289309706, 5983.37174596661, 5983.670898100646, 6415.807525774234, 6435.452986496107, 6457.031445283245, 6472.093906853044, 6472.931966225614, 5846.386129456431, 5871.735771890275, 5947.762089516371, 6064.302605200371, 6116.021436570128, 3481.721462283011, 3493.5633045869267, 3500.8774692886136, 3503.4394496880377, 3503.737219708532, 6712.765053223114, 6778.118844550177, 6780.694868730919, 6785.050092986986, 6787.864242715217, 6562.967185164139, 6662.933370666231, 6686.699098540577, 6688.799336019927, 6709.93290067093, 6722.798316050428, 6776.728930842711, 6782.084418603426, 6784.728610855609, 6786.558873673195, 6506.772262970962, 6514.902276465762, 6516.674166291761, 6519.315471875385, 6523.445507131947, 6326.493880489457, 6443.871122577429, 6449.967750161407, 6458.7093580789915, 6462.063000864754, 6701.095352127595, 6759.256481787098, 6761.560498567577, 6766.0, 6767.39093481589, 4616.16908956391, 4618.076384723136, 4619.584237418649, 4619.976900115478, 4622.029373831533, 6431.1317972073175, 6511.641859697762, 6534.444572211415, 6535.57518761279, 6535.705893234721, 6333.493320534439, 6334.556581039283, 6342.270638876404, 6345.682715864281, 6353.142325786144, 6326.0, 6328.430441260309, 6334.651594162181, 6338.714757836001, 6344.143540621957, 6068.786242751379, 6190.071489276645, 6212.06818977157, 6213.254409470893, 6215.720292586754, 6347.841303967438, 6350.650714210578, 6351.618902865843, 6358.205224346957, 6367.108604795239, 6193.81418557444, 6202.782902598387, 6203.131561581292, 6209.906851397142, 6219.502439804714], "unit": "score", "name": "prototype.html", "value": 4777.643680444089}, {"lowerIsBetter": false, "replicates": [838.4885220015793, 851.5146366571053, 851.5529347092777, 856.5931182688224, 860.2000139869922, 13682.04225704201, 13932.582022539314, 13942.860571394283, 13961.790573141398, 13974.091684040543, 13096.541621043265, 14255.429782808702, 14696.265186740673, 14709.11745295283, 14718.0, 510.30343581011834, 811.6672164412593, 825.9215374539409, 826.1738261738262, 826.9875951860727, 513.5095983335905, 517.5135372749603, 520.8020952038239, 813.032491335309, 829.85062688716, 862.7756783236372, 868.2099289646424, 873.8601823708208, 874.6457684637732, 874.9868751968726, 855.1149560205158, 865.5196366016858, 866.030046348091, 866.1468453573225, 866.23338345564, 468.33262600794075, 475.4651017605194, 476.57346674725926, 624.9812505624793, 625.4558534075384, 13343.799843002364, 13474.19154850712, 13477.86522134776, 13481.528146514825, 13542.119762215523, 11663.883361166365, 12095.637130886087, 12153.210041347284, 12619.747605047847, 12847.164934279335, 9724.319297649168, 10211.897881021243, 10257.43584102874, 10329.276950613461, 10628.415437150954, 3576.8032758198287, 3601.7478776485655, 3613.674769270778, 3662.9084272893124, 3739.813009349549, 48127.51872481265, 48264.758676206395, 48386.7580662098, 48610.27084593734, 49085.0, 10077.798444031077, 10329.483525823678, 10378.0, 10439.582416703246, 10451.16390688743, 17893.28426862937, 17935.282588696566, 17963.101844907702, 17989.100544972698, 17989.460316190536, 7072.222055573883, 7144.821379465555, 7205.531640443354, 7215.206327303992, 7363.77908662741, 4018.6383225509257, 4098.4876890388705, 4149.605787450188, 4202.894927626772, 4381.101874115799, 3056.7096125868006, 3058.3271680230314, 3075.185075954874, 3077.692230776949, 3090.520969249725, 561.4722161168488, 566.2779955556616, 567.6934455394041, 572.8081092833947, 588.6409290332894, 525.6977238088115, 558.0178885162144, 562.6989560585067, 600.8467840700594, 609.6921054867264, 7493.213212612706, 7807.570583617842, 7920.0, 7962.960185199153, 8045.678172873137, 461.6791330025667, 511.63929429751937, 597.8535258861607, 611.5780111722897, 625.2309659119309, 3443.345764304774, 3518.1204698825295, 3536.717062634983, 3594.4788005739542, 3614.8915532534065, 54439.45560544423, 55559.72220138874, 55650.443495565334, 55852.720736396055, 58997.70501147467, 49832.252516212284, 50598.49401506012, 50895.23657145146, 51407.7429612857, 53311.0, 44644.55355446469, 44804.55195448004, 45250.64248072563, 45959.0, 46336.5366346339, 7773.494722842997, 7776.7278145264645, 8287.62705678234, 8316.875246871181, 8465.111163328009, 35455.82272088623, 35658.46512302369, 35667.46498802572, 37199.0, 37308.6269137316, 40743.388849166695, 41318.58681413268, 44182.55817441913, 45531.31703024391, 46544.301835471815, 9835.65575204893, 9846.852297215404, 9951.900480995097, 10078.344907580984, 10121.69634910954, 10353.74115647115, 10355.94822025885, 10418.791624167627, 11453.19827612059, 11599.130065244972, 10399.32404393712, 10549.419781912069, 10663.786724265627, 10695.251332406657, 11021.393823339473, 9738.75653108678, 10058.19534437258, 10127.442990635585, 10355.43045132525, 10373.896261037595, 7647.426443016685, 10170.745731356776, 10285.331453455801, 10510.579576817148, 10579.5239214234, 8855.114488551093, 8981.191692747683, 9037.68368107113, 9162.450252984841, 9198.126178013077, 8436.0, 8618.65525379003, 8786.769852220566, 8904.19862212404, 8906.287497000354], "unit": "score", "name": "yui.html", "value": 6041.369641486616}], "name": "dromaeo_css", "value": 6815.482730605024}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 110.0, 104.0, 112.0, 114.0, 110.0, 101.0, 109.0, 110.0, 102.0], "unit": "score", "name": "ai-astar", "value": 108.1}, {"lowerIsBetter": true, "replicates": [151.0, 132.0, 155.0, 161.0, 129.0, 160.0, 158.0, 129.0, 173.0, 124.0], "unit": "score", "name": "audio-beat-detection", "value": 147.2}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 160.0, 161.0, 162.0, 162.0, 161.0, 161.0, 162.0, 160.0], "unit": "score", "name": "audio-dft", "value": 161.0}, {"lowerIsBetter": true, "replicates": [74.0, 73.0, 86.0, 95.0, 73.0, 74.0, 72.0, 98.0, 90.0, 73.0], "unit": "score", "name": "audio-fft", "value": 80.8}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 138.0, 96.0, 97.0, 97.0, 142.0, 97.0, 96.0, 141.0], "unit": "score", "name": "audio-oscillator", "value": 109.6}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 108.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.0}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0, 144.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.1}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [57.0, 55.0, 57.0, 55.0, 55.0, 56.0, 55.0, 65.0, 54.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 56.3}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 68.0, 68.0, 69.0, 70.0, 68.0, 68.0, 74.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.1}, {"lowerIsBetter": true, "replicates": [86.0, 85.0, 86.0, 84.0, 85.0, 85.0, 85.0, 85.0, 86.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.3}, {"lowerIsBetter": true, "replicates": [122.0, 119.0, 118.0, 112.0, 124.0, 115.0, 115.0, 118.0, 126.0, 114.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.3}, {"lowerIsBetter": true, "replicates": [140.0, 152.0, 150.0, 150.0, 150.0, 143.0, 151.0, 151.0, 151.0, 149.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.7}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 71.0, 67.0, 67.0, 67.0, 67.0, 68.0, 70.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.3}], "name": "kraken", "value": 1502.4999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [169.34801016088062], "unit": "score", "name": "Richards", "value": 208.45830999999995}, {"lowerIsBetter": false, "replicates": [197.1608832807571], "unit": "score", "name": "DeltaBlue", "value": 335.35049599999996}, {"lowerIsBetter": false, "replicates": [284.4950213371266], "unit": "score", "name": "Encrypt", "value": 935.6262149999995}, {"lowerIsBetter": false, "replicates": [5240.837696335078], "unit": "score", "name": "Decrypt", "value": 50.78978121878119}, {"lowerIsBetter": false, "replicates": [1103.7527593818984], "unit": "score", "name": "RayTrace", "value": 670.4300340000001}, {"lowerIsBetter": false, "replicates": [800.640512409928], "unit": "score", "name": "Earley", "value": 832.4122870000002}, {"lowerIsBetter": false, "replicates": [12575.0], "unit": "score", "name": "Boyer", "value": 52.99904572564615}, {"lowerIsBetter": false, "replicates": [25641.02564102564], "unit": "score", "name": "RegExp", "value": 35.52841499999999}, {"lowerIsBetter": false, "replicates": [670.911528150134], "unit": "score", "name": "Splay", "value": 121.46310889110887}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 20567.911658765537}]} 17:21:20 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "20567.91"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1502.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6815.48"}}} 17:21:20 INFO - Return code: 0 17:21:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 17:21:20 INFO - # TBPL SUCCESS # 17:21:20 INFO - Running post-action listener: _resource_record_post_action 17:21:20 INFO - Running post-run listener: _resource_record_post_run 17:21:21 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 8192; Write bytes: 547622912; Read time: 104; Write time: 437280 17:21:21 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 239394816; Read time: 0; Write time: 278956 17:21:21 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 8192; Write bytes: 307855360; Read time: 104; Write time: 158280 17:21:21 INFO - Running post-run listener: _upload_blobber_files 17:21:21 INFO - Blob upload gear active. 17:21:21 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 17:21:21 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:21:21 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', 'B2G-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 17:21:21 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 B2G-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 17:21:22 INFO - (blobuploader) - INFO - Open directory for files ... 17:21:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:21:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:21:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:21:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:21:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:21:22 INFO - (blobuploader) - INFO - Done attempting. 17:21:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 17:21:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:21:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:21:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:21:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:21:23 INFO - (blobuploader) - INFO - Done attempting. 17:21:23 INFO - (blobuploader) - INFO - Iteration through files over. 17:21:23 INFO - Return code: 0 17:21:23 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 17:21:23 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 17:21:23 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/e3f2451cdb9c110056632c7b2b53f3d240c9b3428d6e922a73f994da639a91c18b12536184e92a40ae00b090a5b1b4c0dd5b9ca00983f9b044bdc0d0e55d3de4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/91fa09a1e02448a5ea57df195d5b6918a7caffba98b3d7d089e7fda0790886111e44d293b365a131a3f412ad4e8108fe8efe0e50f56b2f3fe60fb65d50ee921d"} 17:21:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 17:21:23 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 17:21:23 INFO - Contents: 17:21:23 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/e3f2451cdb9c110056632c7b2b53f3d240c9b3428d6e922a73f994da639a91c18b12536184e92a40ae00b090a5b1b4c0dd5b9ca00983f9b044bdc0d0e55d3de4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/91fa09a1e02448a5ea57df195d5b6918a7caffba98b3d7d089e7fda0790886111e44d293b365a131a3f412ad4e8108fe8efe0e50f56b2f3fe60fb65d50ee921d"} 17:21:23 INFO - Copying logs to upload dir... 17:21:23 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1264.416809 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2015-12-30 17:21:23.259144) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-30 17:21:23.262444) ========= 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=c402a24d74c70935940d60dd000001de-1451523617.635206-17506392 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/e3f2451cdb9c110056632c7b2b53f3d240c9b3428d6e922a73f994da639a91c18b12536184e92a40ae00b090a5b1b4c0dd5b9ca00983f9b044bdc0d0e55d3de4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/91fa09a1e02448a5ea57df195d5b6918a7caffba98b3d7d089e7fda0790886111e44d293b365a131a3f412ad4e8108fe8efe0e50f56b2f3fe60fb65d50ee921d"} build_url:https://queue.taskcluster.net/v1/task/Y9s-1YWTRbajX_2e3tC95A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011442 build_url: 'https://queue.taskcluster.net/v1/task/Y9s-1YWTRbajX_2e3tC95A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/e3f2451cdb9c110056632c7b2b53f3d240c9b3428d6e922a73f994da639a91c18b12536184e92a40ae00b090a5b1b4c0dd5b9ca00983f9b044bdc0d0e55d3de4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/91fa09a1e02448a5ea57df195d5b6918a7caffba98b3d7d089e7fda0790886111e44d293b365a131a3f412ad4e8108fe8efe0e50f56b2f3fe60fb65d50ee921d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-30 17:21:23.287460) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 17:21:23.287796) ========= 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=c402a24d74c70935940d60dd000001de-1451523617.635206-17506392 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004602 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 17:21:23.373109) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-30 17:21:23.373471) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-30 17:21:23.373831) ========= ========= Total master_lag: 0.22 =========