builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-055 starttime: 1452275789.59 results: success (0) buildid: 20160108073153 builduid: 59dd9ac8fb6f4c0ab5c6ecc5f606f35a revision: 3f780f4b14acab29b16bc4141a44180a8af9dd08 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-08 09:56:29.594450) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-08 09:56:29.594976) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-08 09:56:29.595369) ========= 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=82e07478c745e68b1fe4678a000001bc-1452272963.565224-219127935 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006366 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-08 09:56:29.621223) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-08 09:56:29.621581) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-08 09:56:29.649062) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 09:56:29.649493) ========= 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=82e07478c745e68b1fe4678a000001bc-1452272963.565224-219127935 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016063 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 09:56:29.700752) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-08 09:56:29.701094) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-08 09:56:29.701512) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 09:56:29.701837) ========= 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=82e07478c745e68b1fe4678a000001bc-1452272963.565224-219127935 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-08 09:56:29-- 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% 78.1M=0s 2016-01-08 09:56:29 (78.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.094176 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 09:56:29.813364) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 09:56:29.813681) ========= 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=82e07478c745e68b1fe4678a000001bc-1452272963.565224-219127935 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.082892 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 09:56:29.908421) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 09:56:29.908796) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3f780f4b14acab29b16bc4141a44180a8af9dd08 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 3f780f4b14acab29b16bc4141a44180a8af9dd08 --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=82e07478c745e68b1fe4678a000001bc-1452272963.565224-219127935 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-08 09:56:30,071 truncating revision to first 12 chars 2016-01-08 09:56:30,071 Setting DEBUG logging. 2016-01-08 09:56:30,071 attempt 1/10 2016-01-08 09:56:30,071 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3f780f4b14ac?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-08 09:56:30,327 unpacking tar archive at: mozilla-central-3f780f4b14ac/testing/mozharness/ program finished with exit code 0 elapsedTime=0.525621 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 09:56:30.451145) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-08 09:56:30.451462) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-08 09:56:30.462313) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-08 09:56:30.462606) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-08 09:56:30.463043) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2016-01-08 09:56:30.463369) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=82e07478c745e68b1fe4678a000001bc-1452272963.565224-219127935 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:56:30 INFO - MultiFileLogger online at 20160108 09:56:30 in /builds/slave/test-pgo 09:56:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 09:56:30 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 09:56:30 INFO - {'append_to_log': False, 09:56:30 INFO - 'base_work_dir': '/builds/slave/test-pgo', 09:56:30 INFO - 'blob_upload_branch': 'Firefox', 09:56:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 09:56:30 INFO - 'branch': 'Firefox', 09:56:30 INFO - 'buildbot_json_path': 'buildprops.json', 09:56:30 INFO - 'config_files': ('talos/linux_config.py',), 09:56:30 INFO - 'default_actions': ('clobber', 09:56:30 INFO - 'read-buildbot-config', 09:56:30 INFO - 'download-and-extract', 09:56:30 INFO - 'populate-webroot', 09:56:30 INFO - 'create-virtualenv', 09:56:30 INFO - 'install', 09:56:30 INFO - 'run-tests'), 09:56:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:56:30 INFO - 'download_minidump_stackwalk': True, 09:56:30 INFO - 'download_symbols': 'ondemand', 09:56:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:56:30 INFO - 'tooltool.py': '/tools/tooltool.py', 09:56:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:56:30 INFO - '/tools/misc-python/virtualenv.py')}, 09:56:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:56:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:56:30 INFO - 'installer_path': 'installer.exe', 09:56:30 INFO - 'log_level': 'info', 09:56:30 INFO - 'log_name': 'talos', 09:56:30 INFO - 'log_to_console': True, 09:56:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:56:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:56:30 INFO - 'opt_config_files': (), 09:56:30 INFO - 'pip_index': False, 09:56:30 INFO - 'sps_profile': False, 09:56:30 INFO - 'sps_profile_interval': 0, 09:56:30 INFO - 'suite': 'dromaeojs', 09:56:30 INFO - 'system_bits': '32', 09:56:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:56:30 INFO - 'title': 'talos-linux64-ix-055', 09:56:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:56:30 INFO - 'use_talos_json': True, 09:56:30 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 09:56:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:56:30 INFO - 'work_dir': 'build'} 09:56:30 INFO - ##### 09:56:30 INFO - ##### Running clobber step. 09:56:30 INFO - ##### 09:56:30 INFO - Running pre-action listener: _resource_record_pre_action 09:56:30 INFO - Running main action method: clobber 09:56:30 INFO - rmtree: /builds/slave/test-pgo/build 09:56:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 09:56:35 INFO - Running post-action listener: _resource_record_post_action 09:56:35 INFO - ##### 09:56:35 INFO - ##### Running read-buildbot-config step. 09:56:35 INFO - ##### 09:56:35 INFO - Running pre-action listener: _resource_record_pre_action 09:56:35 INFO - Running main action method: read_buildbot_config 09:56:35 INFO - Using buildbot properties: 09:56:35 INFO - { 09:56:35 INFO - "project": "", 09:56:35 INFO - "product": "firefox", 09:56:35 INFO - "script_repo_revision": "production", 09:56:35 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 09:56:35 INFO - "repository": "", 09:56:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 09:56:35 INFO - "buildid": "20160108073153", 09:56:35 INFO - "pgo_build": "True", 09:56:35 INFO - "basedir": "/builds/slave/test-pgo", 09:56:35 INFO - "buildnumber": 297, 09:56:35 INFO - "slavename": "talos-linux64-ix-055", 09:56:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:56:35 INFO - "platform": "ubuntu64_hw", 09:56:35 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 09:56:35 INFO - "branch": "mozilla-central", 09:56:35 INFO - "repo_path": "mozilla-central", 09:56:35 INFO - "revision": "3f780f4b14acab29b16bc4141a44180a8af9dd08", 09:56:35 INFO - "stage_platform": "linux64-pgo", 09:56:35 INFO - "builduid": "59dd9ac8fb6f4c0ab5c6ecc5f606f35a", 09:56:35 INFO - "slavebuilddir": "test" 09:56:35 INFO - } 09:56:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/LFm6ntJKQnSO5ZrguWKmpw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 09:56:35 INFO - Running post-action listener: _resource_record_post_action 09:56:35 INFO - ##### 09:56:35 INFO - ##### Running download-and-extract step. 09:56:35 INFO - ##### 09:56:35 INFO - Running pre-action listener: _resource_record_pre_action 09:56:35 INFO - Running main action method: download_and_extract 09:56:35 INFO - mkdir: /builds/slave/test-pgo/build/tests 09:56:35 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')]} 09:56:35 INFO - https://queue.taskcluster.net/v1/task/LFm6ntJKQnSO5ZrguWKmpw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:56:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LFm6ntJKQnSO5ZrguWKmpw/artifacts/public/build/test_packages.json 09:56:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LFm6ntJKQnSO5ZrguWKmpw/artifacts/public/build/test_packages.json 09:56:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LFm6ntJKQnSO5ZrguWKmpw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 09:56:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LFm6ntJKQnSO5ZrguWKmpw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 09:56:38 INFO - Downloaded 1302 bytes. 09:56:38 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 09:56:38 INFO - Using the following test package requirements: 09:56:38 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 09:56:38 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:56:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:56:38 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:56:38 INFO - u'jsshell-linux-x86_64.zip'], 09:56:38 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:56:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:56:38 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 09:56:38 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:56:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:56:38 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:56:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:56:38 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:56:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:56:38 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 09:56:38 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:56:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:56:38 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:56:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:38 INFO - https://queue.taskcluster.net/v1/task/LFm6ntJKQnSO5ZrguWKmpw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:56:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LFm6ntJKQnSO5ZrguWKmpw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 09:56:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LFm6ntJKQnSO5ZrguWKmpw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 09:56:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LFm6ntJKQnSO5ZrguWKmpw/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 09:56:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LFm6ntJKQnSO5ZrguWKmpw/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 09:56:48 INFO - Downloaded 24028131 bytes. 09:56:48 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 09:56:48 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 09:56:48 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 09:56:49 INFO - Return code: 0 09:56:49 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 09:56: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')]} 09:56:49 INFO - https://queue.taskcluster.net/v1/task/LFm6ntJKQnSO5ZrguWKmpw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:56:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LFm6ntJKQnSO5ZrguWKmpw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 09:56:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LFm6ntJKQnSO5ZrguWKmpw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 09:56:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LFm6ntJKQnSO5ZrguWKmpw/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 09:56:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LFm6ntJKQnSO5ZrguWKmpw/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 09:56:52 INFO - Downloaded 24028131 bytes. 09:56:52 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 09:56:52 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 09:56:52 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 09:56:53 INFO - Return code: 0 09:56:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:53 INFO - https://queue.taskcluster.net/v1/task/LFm6ntJKQnSO5ZrguWKmpw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:56:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LFm6ntJKQnSO5ZrguWKmpw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 09:56:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LFm6ntJKQnSO5ZrguWKmpw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 09:56:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LFm6ntJKQnSO5ZrguWKmpw/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 09:56:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LFm6ntJKQnSO5ZrguWKmpw/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 09:56:54 INFO - Downloaded 11132285 bytes. 09:56:54 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 09:56:54 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 09:56:54 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 09:56:54 INFO - Return code: 0 09:56:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:54 INFO - https://queue.taskcluster.net/v1/task/LFm6ntJKQnSO5ZrguWKmpw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:56:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LFm6ntJKQnSO5ZrguWKmpw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 09:56:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LFm6ntJKQnSO5ZrguWKmpw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 09:56:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LFm6ntJKQnSO5ZrguWKmpw/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 09:56:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LFm6ntJKQnSO5ZrguWKmpw/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 09:56:55 INFO - Downloaded 55928647 bytes. 09:56:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LFm6ntJKQnSO5ZrguWKmpw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 09:56:55 INFO - mkdir: /builds/slave/test-pgo/properties 09:56:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 09:56:55 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 09:56:55 INFO - Contents: 09:56:55 INFO - build_url:https://queue.taskcluster.net/v1/task/LFm6ntJKQnSO5ZrguWKmpw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 09:56:55 INFO - Running post-action listener: _resource_record_post_action 09:56:55 INFO - Running post-action listener: set_extra_try_arguments 09:56:55 INFO - ##### 09:56:55 INFO - ##### Running populate-webroot step. 09:56:55 INFO - ##### 09:56:55 INFO - Running pre-action listener: _resource_record_pre_action 09:56:55 INFO - Running main action method: populate_webroot 09:56:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:56:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:56:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:56:55 INFO - '--tppagecycles', 09:56:55 INFO - '7'], 09:56:55 INFO - 'tests': ['tsvgm']}}, 09:56:55 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:56:55 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:56:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:56:55 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:56:55 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:56:55 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:56:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:56:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:56:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:56:55 INFO - 'talos_options': ['--e10s'], 09:56:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:56:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:56:55 INFO - 'tests': ['damp', 'tps']}, 09:56:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:56:55 INFO - 'talos_options': ['--e10s'], 09:56:55 INFO - 'tests': ['damp', 'tps']}, 09:56:55 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:56:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:56:55 INFO - 'other': {'tests': ['a11yr', 09:56:55 INFO - 'ts_paint', 09:56:55 INFO - 'tpaint', 09:56:55 INFO - 'sessionrestore', 09:56:55 INFO - 'sessionrestore_no_auto_restore']}, 09:56:55 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:56:55 INFO - 'tests': ['a11yr', 09:56:55 INFO - 'ts_paint', 09:56:55 INFO - 'tpaint', 09:56:55 INFO - 'sessionrestore', 09:56:55 INFO - 'sessionrestore_no_auto_restore']}, 09:56:55 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:56:55 INFO - 'tests': ['a11yr', 09:56:55 INFO - 'ts_paint', 09:56:55 INFO - 'tpaint', 09:56:55 INFO - 'sessionrestore', 09:56:55 INFO - 'sessionrestore_no_auto_restore']}, 09:56:55 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:56:55 INFO - 'tests': ['a11yr', 09:56:55 INFO - 'ts_paint', 09:56:55 INFO - 'tpaint', 09:56:55 INFO - 'sessionrestore', 09:56:55 INFO - 'sessionrestore_no_auto_restore']}, 09:56:55 INFO - 'other_l64': {'tests': ['a11yr', 09:56:55 INFO - 'ts_paint', 09:56:55 INFO - 'tpaint', 09:56:55 INFO - 'sessionrestore', 09:56:55 INFO - 'sessionrestore_no_auto_restore']}, 09:56:55 INFO - 'other_nol64': {'tests': ['a11yr', 09:56:55 INFO - 'ts_paint', 09:56:55 INFO - 'tpaint', 09:56:55 INFO - 'sessionrestore', 09:56:55 INFO - 'sessionrestore_no_auto_restore']}, 09:56:55 INFO - 'svgr': {'tests': ['tsvgx', 09:56:55 INFO - 'tsvgr_opacity', 09:56:55 INFO - 'tart', 09:56:55 INFO - 'tscrollx', 09:56:55 INFO - 'cart']}, 09:56:55 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:56:55 INFO - 'tests': ['tsvgx', 09:56:55 INFO - 'tsvgr_opacity', 09:56:55 INFO - 'tart', 09:56:55 INFO - 'tscrollx', 09:56:55 INFO - 'cart']}, 09:56:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:56:55 INFO - 'tests': ['tp5o']}, 09:56:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:56:55 INFO - 'talos_options': ['--e10s'], 09:56:55 INFO - 'tests': ['tp5o']}, 09:56:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:56:55 INFO - 'talos_options': ['--xperf_path', 09:56:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:56:55 INFO - 'tests': ['tp5n']}, 09:56:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:56:55 INFO - 'talos_options': ['--e10s', 09:56:55 INFO - '--xperf_path', 09:56:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:56:55 INFO - 'tests': ['tp5n']}}, 09:56:55 INFO - 'talos.zip': {'path': '', 09:56:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:56:55 INFO - Running post-action listener: _resource_record_post_action 09:56:55 INFO - ##### 09:56:55 INFO - ##### Running create-virtualenv step. 09:56:55 INFO - ##### 09:56:55 INFO - Running pre-action listener: _resource_record_pre_action 09:56:55 INFO - Running main action method: create_virtualenv 09:56:55 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 09:56:55 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 09:56:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 09:56:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:56:56 INFO - Using real prefix '/usr' 09:56:56 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 09:56:56 INFO - Installing distribute.............................................................................................................................................................................................done. 09:56:58 INFO - Installing pip.................done. 09:56:58 INFO - Return code: 0 09:56:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 09:56:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f52c27e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a31630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac2840>, '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 0x2a2f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a2fb60>, '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': '82e07478c745e68b1fe4678a000001bc-1452272963.565224-219127935', '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 09:56:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 09:56:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:56:58 INFO - Using env: {'DISPLAY': ':0', 09:56:58 INFO - 'HOME': '/home/cltbld', 09:56:58 INFO - 'LANG': 'en_US.UTF-8', 09:56:58 INFO - 'LANGUAGE': 'en_US:en', 09:56:58 INFO - 'LOGNAME': 'cltbld', 09:56:58 INFO - 'MAIL': '/var/mail/cltbld', 09:56:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:58 INFO - 'MOZ_NO_REMOTE': '1', 09:56:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:56:58 INFO - 'NO_EM_RESTART': '1', 09:56:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:56:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:56:58 INFO - 'PWD': '/builds/slave/test-pgo', 09:56:58 INFO - 'SHELL': '/bin/bash', 09:56:58 INFO - 'SHLVL': '1', 09:56:58 INFO - 'TERM': 'linux', 09:56:58 INFO - 'TMOUT': '86400', 09:56:58 INFO - 'USER': 'cltbld', 09:56:58 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1452272963.565224-219127935', 09:56:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:58 INFO - '_': '/tools/buildbot/bin/python'} 09:56:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:58 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 09:56:58 INFO - Cleaning up... 09:56:58 INFO - Return code: 0 09:56:58 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 09:56:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f52c27e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a31630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac2840>, '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 0x2a2f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a2fb60>, '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': '82e07478c745e68b1fe4678a000001bc-1452272963.565224-219127935', '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 09:56:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 09:56:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 09:56:58 INFO - Using env: {'DISPLAY': ':0', 09:56:58 INFO - 'HOME': '/home/cltbld', 09:56:58 INFO - 'LANG': 'en_US.UTF-8', 09:56:58 INFO - 'LANGUAGE': 'en_US:en', 09:56:58 INFO - 'LOGNAME': 'cltbld', 09:56:58 INFO - 'MAIL': '/var/mail/cltbld', 09:56:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:58 INFO - 'MOZ_NO_REMOTE': '1', 09:56:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:56:58 INFO - 'NO_EM_RESTART': '1', 09:56:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:56:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:56:58 INFO - 'PWD': '/builds/slave/test-pgo', 09:56:58 INFO - 'SHELL': '/bin/bash', 09:56:58 INFO - 'SHLVL': '1', 09:56:58 INFO - 'TERM': 'linux', 09:56:58 INFO - 'TMOUT': '86400', 09:56:58 INFO - 'USER': 'cltbld', 09:56:58 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1452272963.565224-219127935', 09:56:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:58 INFO - '_': '/tools/buildbot/bin/python'} 09:56:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:58 INFO - Downloading/unpacking psutil>=0.7.1 09:56:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:00 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 09:57:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 09:57:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 09:57:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:57:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:57:00 INFO - Installing collected packages: psutil 09:57:00 INFO - Running setup.py install for psutil 09:57:00 INFO - building 'psutil._psutil_linux' extension 09:57:00 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 09:57:00 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 09:57:01 INFO - building 'psutil._psutil_posix' extension 09:57:01 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 09:57:01 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 09:57:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:57:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:57:01 INFO - Successfully installed psutil 09:57:01 INFO - Cleaning up... 09:57:01 INFO - Return code: 0 09:57:01 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 09:57:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:01 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 0x7f52c27e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a31630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac2840>, '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 0x2a2f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a2fb60>, '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': '82e07478c745e68b1fe4678a000001bc-1452272963.565224-219127935', '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 09:57:01 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 09:57:01 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 09:57:01 INFO - Using env: {'DISPLAY': ':0', 09:57:01 INFO - 'HOME': '/home/cltbld', 09:57:01 INFO - 'LANG': 'en_US.UTF-8', 09:57:01 INFO - 'LANGUAGE': 'en_US:en', 09:57:01 INFO - 'LOGNAME': 'cltbld', 09:57:01 INFO - 'MAIL': '/var/mail/cltbld', 09:57:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:01 INFO - 'MOZ_NO_REMOTE': '1', 09:57:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:01 INFO - 'NO_EM_RESTART': '1', 09:57:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:57:01 INFO - 'PWD': '/builds/slave/test-pgo', 09:57:01 INFO - 'SHELL': '/bin/bash', 09:57:01 INFO - 'SHLVL': '1', 09:57:01 INFO - 'TERM': 'linux', 09:57:01 INFO - 'TMOUT': '86400', 09:57:01 INFO - 'USER': 'cltbld', 09:57:01 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1452272963.565224-219127935', 09:57:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:01 INFO - '_': '/tools/buildbot/bin/python'} 09:57:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:01 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:57:01 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 09:57:01 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 09:57:01 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 09:57:01 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 09:57:01 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 09:57:01 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 09:57:03 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:57:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 09:57:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:57:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:57:03 INFO - Installing collected packages: mozsystemmonitor 09:57:03 INFO - Running setup.py install for mozsystemmonitor 09:57:03 INFO - Successfully installed mozsystemmonitor 09:57:03 INFO - Cleaning up... 09:57:03 INFO - Return code: 0 09:57:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 09:57:03 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')]} 09:57:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:03 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')]} 09:57:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:03 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 0x7f52c27e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a31630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac2840>, '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 0x2a2f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a2fb60>, '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': '82e07478c745e68b1fe4678a000001bc-1452272963.565224-219127935', '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 09:57:03 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 09:57:03 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 09:57:03 INFO - Using env: {'DISPLAY': ':0', 09:57:03 INFO - 'HOME': '/home/cltbld', 09:57:03 INFO - 'LANG': 'en_US.UTF-8', 09:57:03 INFO - 'LANGUAGE': 'en_US:en', 09:57:03 INFO - 'LOGNAME': 'cltbld', 09:57:03 INFO - 'MAIL': '/var/mail/cltbld', 09:57:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:03 INFO - 'MOZ_NO_REMOTE': '1', 09:57:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:03 INFO - 'NO_EM_RESTART': '1', 09:57:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:57:03 INFO - 'PWD': '/builds/slave/test-pgo', 09:57:03 INFO - 'SHELL': '/bin/bash', 09:57:03 INFO - 'SHLVL': '1', 09:57:03 INFO - 'TERM': 'linux', 09:57:03 INFO - 'TMOUT': '86400', 09:57:03 INFO - 'USER': 'cltbld', 09:57:03 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1452272963.565224-219127935', 09:57:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:03 INFO - '_': '/tools/buildbot/bin/python'} 09:57:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:03 INFO - Downloading/unpacking blobuploader==1.2.4 09:57:03 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 09:57:03 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 09:57:03 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 09:57:03 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 09:57:03 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 09:57:03 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 09:57:05 INFO - Downloading blobuploader-1.2.4.tar.gz 09:57:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 09:57:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:57:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:57:05 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 09:57:05 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 09:57:05 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 09:57:05 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 09:57:05 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 09:57:05 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 09:57:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 09:57:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 09:57:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:57:05 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 09:57:05 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 09:57:05 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 09:57:05 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 09:57:05 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 09:57:05 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 09:57:05 INFO - Downloading docopt-0.6.1.tar.gz 09:57:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 09:57:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 09:57:06 INFO - Installing collected packages: blobuploader, requests, docopt 09:57:06 INFO - Running setup.py install for blobuploader 09:57:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:57:06 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 09:57:06 INFO - Running setup.py install for requests 09:57:06 INFO - Running setup.py install for docopt 09:57:06 INFO - Successfully installed blobuploader requests docopt 09:57:06 INFO - Cleaning up... 09:57:06 INFO - Return code: 0 09:57:06 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:57:06 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')]} 09:57:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:06 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')]} 09:57:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:06 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 0x7f52c27e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a31630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac2840>, '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 0x2a2f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a2fb60>, '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': '82e07478c745e68b1fe4678a000001bc-1452272963.565224-219127935', '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 09:57:06 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 09:57:06 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 09:57:06 INFO - Using env: {'DISPLAY': ':0', 09:57:06 INFO - 'HOME': '/home/cltbld', 09:57:06 INFO - 'LANG': 'en_US.UTF-8', 09:57:06 INFO - 'LANGUAGE': 'en_US:en', 09:57:06 INFO - 'LOGNAME': 'cltbld', 09:57:06 INFO - 'MAIL': '/var/mail/cltbld', 09:57:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:06 INFO - 'MOZ_NO_REMOTE': '1', 09:57:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:06 INFO - 'NO_EM_RESTART': '1', 09:57:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:57:06 INFO - 'PWD': '/builds/slave/test-pgo', 09:57:06 INFO - 'SHELL': '/bin/bash', 09:57:06 INFO - 'SHLVL': '1', 09:57:06 INFO - 'TERM': 'linux', 09:57:06 INFO - 'TMOUT': '86400', 09:57:06 INFO - 'USER': 'cltbld', 09:57:06 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1452272963.565224-219127935', 09:57:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:06 INFO - '_': '/tools/buildbot/bin/python'} 09:57:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:57:06 INFO - Running setup.py (path:/tmp/pip-6z2G9R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:57:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:57:06 INFO - Running setup.py (path:/tmp/pip-Hkp2o0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:57:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:57:07 INFO - Running setup.py (path:/tmp/pip-GJXUhI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:57:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:57:07 INFO - Running setup.py (path:/tmp/pip-BlL8rP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:57:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:57:07 INFO - Running setup.py (path:/tmp/pip-j5l5s9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:57:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:57:07 INFO - Running setup.py (path:/tmp/pip-0iKV45-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:57:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:57:07 INFO - Running setup.py (path:/tmp/pip-uJGHm8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:57:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:57:07 INFO - Running setup.py (path:/tmp/pip-6Ro0xq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:57:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:57:07 INFO - Running setup.py (path:/tmp/pip-OBm4cl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:57:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:57:07 INFO - Running setup.py (path:/tmp/pip-rX9P8P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:57:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:57:07 INFO - Running setup.py (path:/tmp/pip-7CHY4J-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:57:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:57:07 INFO - Running setup.py (path:/tmp/pip-qPLjcm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:57:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:57:07 INFO - Running setup.py (path:/tmp/pip-ELp0Aw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:57:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:57:07 INFO - Running setup.py (path:/tmp/pip-5ROGmY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:57:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:57:07 INFO - Running setup.py (path:/tmp/pip-JAOsTb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:57:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:57:07 INFO - Running setup.py (path:/tmp/pip-WQ9C5U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:57:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:57:08 INFO - Running setup.py (path:/tmp/pip-1HAa0_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:57:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:57:08 INFO - Running setup.py install for manifestparser 09:57:08 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 09:57:08 INFO - Running setup.py install for mozcrash 09:57:08 INFO - Running setup.py install for mozdebug 09:57:08 INFO - Running setup.py install for mozdevice 09:57:08 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 09:57:08 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 09:57:08 INFO - Running setup.py install for mozfile 09:57:08 INFO - Running setup.py install for mozhttpd 09:57:08 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 09:57:08 INFO - Running setup.py install for mozinfo 09:57:08 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 09:57:08 INFO - Running setup.py install for mozInstall 09:57:08 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 09:57:08 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 09:57:08 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 09:57:08 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 09:57:08 INFO - Running setup.py install for mozleak 09:57:08 INFO - Running setup.py install for mozlog 09:57:09 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 09:57:09 INFO - Running setup.py install for moznetwork 09:57:09 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 09:57:09 INFO - Running setup.py install for mozprocess 09:57:09 INFO - Running setup.py install for mozprofile 09:57:09 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 09:57:09 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 09:57:09 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 09:57:09 INFO - Running setup.py install for mozrunner 09:57:09 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 09:57:09 INFO - Running setup.py install for mozscreenshot 09:57:09 INFO - Running setup.py install for moztest 09:57:09 INFO - Running setup.py install for mozversion 09:57:09 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 09:57:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:57:09 INFO - Cleaning up... 09:57:09 INFO - Return code: 0 09:57:09 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:57:09 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')]} 09:57:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:09 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')]} 09:57:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:09 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 0x7f52c27e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a31630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac2840>, '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 0x2a2f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a2fb60>, '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': '82e07478c745e68b1fe4678a000001bc-1452272963.565224-219127935', '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 09:57:09 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 09:57:09 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 09:57:09 INFO - Using env: {'DISPLAY': ':0', 09:57:09 INFO - 'HOME': '/home/cltbld', 09:57:09 INFO - 'LANG': 'en_US.UTF-8', 09:57:09 INFO - 'LANGUAGE': 'en_US:en', 09:57:09 INFO - 'LOGNAME': 'cltbld', 09:57:09 INFO - 'MAIL': '/var/mail/cltbld', 09:57:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:09 INFO - 'MOZ_NO_REMOTE': '1', 09:57:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:09 INFO - 'NO_EM_RESTART': '1', 09:57:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:57:09 INFO - 'PWD': '/builds/slave/test-pgo', 09:57:09 INFO - 'SHELL': '/bin/bash', 09:57:09 INFO - 'SHLVL': '1', 09:57:09 INFO - 'TERM': 'linux', 09:57:09 INFO - 'TMOUT': '86400', 09:57:09 INFO - 'USER': 'cltbld', 09:57:09 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1452272963.565224-219127935', 09:57:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:09 INFO - '_': '/tools/buildbot/bin/python'} 09:57:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:57:10 INFO - Running setup.py (path:/tmp/pip-IjB8Ia-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:57:10 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)) 09:57:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:57:10 INFO - Running setup.py (path:/tmp/pip-ak2D7J-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:57:10 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)) 09:57:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:57:10 INFO - Running setup.py (path:/tmp/pip-d8fWST-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:57:10 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)) 09:57:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:57:10 INFO - Running setup.py (path:/tmp/pip-OxQwe8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:57:10 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)) 09:57:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:57:10 INFO - Running setup.py (path:/tmp/pip-UXNhz1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:57:10 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)) 09:57:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:57:10 INFO - Running setup.py (path:/tmp/pip-Jb9En7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:57:10 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)) 09:57:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:57:10 INFO - Running setup.py (path:/tmp/pip-whd0wz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:57:10 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)) 09:57:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:57:10 INFO - Running setup.py (path:/tmp/pip-eHzjGn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:57:10 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)) 09:57:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:57:10 INFO - Running setup.py (path:/tmp/pip-OmiPui-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:57:10 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)) 09:57:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:57:10 INFO - Running setup.py (path:/tmp/pip-ubBO6y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:57:10 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)) 09:57:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:57:10 INFO - Running setup.py (path:/tmp/pip-vZz4uE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:57:10 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)) 09:57:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:57:10 INFO - Running setup.py (path:/tmp/pip-d8VwmP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:57:11 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)) 09:57:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:57:11 INFO - Running setup.py (path:/tmp/pip-y1_PwB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:57:11 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)) 09:57:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:57:11 INFO - Running setup.py (path:/tmp/pip-wvY8_7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:57:11 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)) 09:57:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:57:11 INFO - Running setup.py (path:/tmp/pip-333YQ3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:57:11 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)) 09:57:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:57:11 INFO - Running setup.py (path:/tmp/pip-LALgB4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:57:11 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)) 09:57:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:57:11 INFO - Running setup.py (path:/tmp/pip-HbXENQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:57:11 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)) 09:57:11 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)) 09:57:11 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)) 09:57:11 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)) 09:57:11 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)) 09:57:11 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)) 09:57:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 09:57:11 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 09:57:11 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 09:57:11 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 09:57:11 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 09:57:11 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 09:57:11 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 09:57:13 INFO - Downloading blessings-1.5.1.tar.gz 09:57:13 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 09:57:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 09:57:13 INFO - Installing collected packages: blessings 09:57:13 INFO - Running setup.py install for blessings 09:57:13 INFO - Successfully installed blessings 09:57:13 INFO - Cleaning up... 09:57:13 INFO - Return code: 0 09:57:13 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 09:57:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:57:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:57:13 INFO - Reading from file tmpfile_stdout 09:57:13 INFO - Current package versions: 09:57:13 INFO - argparse == 1.2.1 09:57:13 INFO - blessings == 1.5.1 09:57:13 INFO - blobuploader == 1.2.4 09:57:13 INFO - docopt == 0.6.1 09:57:13 INFO - manifestparser == 1.1 09:57:13 INFO - mozInstall == 1.12 09:57:13 INFO - mozcrash == 0.16 09:57:13 INFO - mozdebug == 0.1 09:57:13 INFO - mozdevice == 0.47 09:57:13 INFO - mozfile == 1.2 09:57:13 INFO - mozhttpd == 0.7 09:57:13 INFO - mozinfo == 0.9 09:57:13 INFO - mozleak == 0.1 09:57:13 INFO - mozlog == 3.1 09:57:13 INFO - moznetwork == 0.27 09:57:13 INFO - mozprocess == 0.22 09:57:13 INFO - mozprofile == 0.28 09:57:13 INFO - mozrunner == 6.11 09:57:13 INFO - mozscreenshot == 0.1 09:57:13 INFO - mozsystemmonitor == 0.0 09:57:13 INFO - moztest == 0.7 09:57:13 INFO - mozversion == 1.4 09:57:13 INFO - psutil == 3.1.1 09:57:13 INFO - requests == 1.2.3 09:57:13 INFO - wsgiref == 0.1.2 09:57:13 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:57:13 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')]} 09:57:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:13 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')]} 09:57:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:13 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 0x7f52c27e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a31630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac2840>, '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 0x2a2f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a2fb60>, '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': '82e07478c745e68b1fe4678a000001bc-1452272963.565224-219127935', '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 09:57:13 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 09:57:13 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 09:57:13 INFO - Using env: {'DISPLAY': ':0', 09:57:13 INFO - 'HOME': '/home/cltbld', 09:57:13 INFO - 'LANG': 'en_US.UTF-8', 09:57:13 INFO - 'LANGUAGE': 'en_US:en', 09:57:13 INFO - 'LOGNAME': 'cltbld', 09:57:13 INFO - 'MAIL': '/var/mail/cltbld', 09:57:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:13 INFO - 'MOZ_NO_REMOTE': '1', 09:57:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:13 INFO - 'NO_EM_RESTART': '1', 09:57:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:57:13 INFO - 'PWD': '/builds/slave/test-pgo', 09:57:13 INFO - 'SHELL': '/bin/bash', 09:57:13 INFO - 'SHLVL': '1', 09:57:13 INFO - 'TERM': 'linux', 09:57:13 INFO - 'TMOUT': '86400', 09:57:13 INFO - 'USER': 'cltbld', 09:57:13 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1452272963.565224-219127935', 09:57:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:13 INFO - '_': '/tools/buildbot/bin/python'} 09:57:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:13 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)) 09:57:13 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)) 09:57:13 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)) 09:57:13 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)) 09:57:13 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)) 09:57:13 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)) 09:57:13 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)) 09:57:13 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)) 09:57:13 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)) 09:57:13 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)) 09:57:13 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)) 09:57:13 INFO - Cleaning up... 09:57:13 INFO - Return code: 0 09:57:13 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 09:57:13 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')]} 09:57:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:13 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')]} 09:57:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:13 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 0x7f52c27e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a31630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac2840>, '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 0x2a2f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a2fb60>, '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': '82e07478c745e68b1fe4678a000001bc-1452272963.565224-219127935', '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 09:57:13 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 09:57:13 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 09:57:13 INFO - Using env: {'DISPLAY': ':0', 09:57:13 INFO - 'HOME': '/home/cltbld', 09:57:13 INFO - 'LANG': 'en_US.UTF-8', 09:57:13 INFO - 'LANGUAGE': 'en_US:en', 09:57:13 INFO - 'LOGNAME': 'cltbld', 09:57:13 INFO - 'MAIL': '/var/mail/cltbld', 09:57:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:13 INFO - 'MOZ_NO_REMOTE': '1', 09:57:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:13 INFO - 'NO_EM_RESTART': '1', 09:57:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:57:13 INFO - 'PWD': '/builds/slave/test-pgo', 09:57:13 INFO - 'SHELL': '/bin/bash', 09:57:13 INFO - 'SHLVL': '1', 09:57:13 INFO - 'TERM': 'linux', 09:57:13 INFO - 'TMOUT': '86400', 09:57:13 INFO - 'USER': 'cltbld', 09:57:13 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1452272963.565224-219127935', 09:57:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:13 INFO - '_': '/tools/buildbot/bin/python'} 09:57:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:13 INFO - Downloading/unpacking jsonschema 09:57:13 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 09:57:13 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 09:57:13 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 09:57:13 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 09:57:13 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 09:57:13 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 09:57:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:57:15 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 09:57:15 INFO - Downloading/unpacking functools32 (from jsonschema) 09:57:15 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 09:57:15 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 09:57:15 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 09:57:15 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 09:57:15 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 09:57:15 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 09:57:15 INFO - Downloading functools32-3.2.3-2.tar.gz 09:57:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 09:57:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 09:57:15 INFO - warning: no files found matching '*.txt' 09:57:15 INFO - no previously-included directories found matching 'build' 09:57:15 INFO - no previously-included directories found matching 'dist' 09:57:15 INFO - no previously-included directories found matching '.git*' 09:57:15 INFO - Installing collected packages: jsonschema, functools32 09:57:16 INFO - Running setup.py install for functools32 09:57:16 INFO - warning: no files found matching '*.txt' 09:57:16 INFO - no previously-included directories found matching 'build' 09:57:16 INFO - no previously-included directories found matching 'dist' 09:57:16 INFO - no previously-included directories found matching '.git*' 09:57:16 INFO - Successfully installed jsonschema functools32 09:57:16 INFO - Cleaning up... 09:57:16 INFO - Return code: 0 09:57:16 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 09:57:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:16 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 0x7f52c27e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a31630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac2840>, '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 0x2a2f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a2fb60>, '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': '82e07478c745e68b1fe4678a000001bc-1452272963.565224-219127935', '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 09:57:16 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 09:57:16 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 09:57:16 INFO - Using env: {'DISPLAY': ':0', 09:57:16 INFO - 'HOME': '/home/cltbld', 09:57:16 INFO - 'LANG': 'en_US.UTF-8', 09:57:16 INFO - 'LANGUAGE': 'en_US:en', 09:57:16 INFO - 'LOGNAME': 'cltbld', 09:57:16 INFO - 'MAIL': '/var/mail/cltbld', 09:57:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:16 INFO - 'MOZ_NO_REMOTE': '1', 09:57:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:16 INFO - 'NO_EM_RESTART': '1', 09:57:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:57:16 INFO - 'PWD': '/builds/slave/test-pgo', 09:57:16 INFO - 'SHELL': '/bin/bash', 09:57:16 INFO - 'SHLVL': '1', 09:57:16 INFO - 'TERM': 'linux', 09:57:16 INFO - 'TMOUT': '86400', 09:57:16 INFO - 'USER': 'cltbld', 09:57:16 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1452272963.565224-219127935', 09:57:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:16 INFO - '_': '/tools/buildbot/bin/python'} 09:57:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:16 INFO - Downloading/unpacking flake8 09:57:16 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 09:57:16 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 09:57:16 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 09:57:16 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 09:57:16 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 09:57:16 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 09:57:18 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:57:18 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 09:57:18 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:57:18 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 09:57:18 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 09:57:18 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 09:57:18 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 09:57:18 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 09:57:18 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 09:57:18 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:57:18 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 09:57:18 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:57:18 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 09:57:18 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 09:57:18 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 09:57:18 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 09:57:18 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 09:57:18 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 09:57:18 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 09:57:18 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:57:18 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 09:57:18 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 09:57:18 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 09:57:18 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 09:57:18 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 09:57:18 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 09:57:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 09:57:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 09:57:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:57:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:57:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:57:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:57:18 INFO - no previously-included directories found matching 'docs/_build' 09:57:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:57:18 INFO - Running setup.py install for pep8 09:57:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:57:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:57:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:57:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:57:18 INFO - no previously-included directories found matching 'docs/_build' 09:57:18 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 09:57:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:57:18 INFO - Cleaning up... 09:57:18 INFO - Return code: 0 09:57:18 INFO - Running post-action listener: _resource_record_post_action 09:57:18 INFO - Running post-action listener: _start_resource_monitoring 09:57:19 INFO - Starting resource monitoring. 09:57:19 INFO - ##### 09:57:19 INFO - ##### Running install step. 09:57:19 INFO - ##### 09:57:19 INFO - Running pre-action listener: _resource_record_pre_action 09:57:19 INFO - Running main action method: install 09:57:19 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:57:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:57:19 INFO - Reading from file tmpfile_stdout 09:57:19 INFO - Detecting whether we're running mozinstall >=1.0... 09:57:19 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 09:57:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 09:57:19 INFO - Reading from file tmpfile_stdout 09:57:19 INFO - Output received: 09:57:19 INFO - Usage: mozinstall [options] installer 09:57:19 INFO - Options: 09:57:19 INFO - -h, --help show this help message and exit 09:57:19 INFO - -d DEST, --destination=DEST 09:57:19 INFO - Directory to install application into. [default: 09:57:19 INFO - "/builds/slave/test-pgo"] 09:57:19 INFO - --app=APP Application being installed. [default: firefox] 09:57:19 INFO - mkdir: /builds/slave/test-pgo/build/application 09:57:19 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'] 09:57:19 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 09:57:35 INFO - Reading from file tmpfile_stdout 09:57:35 INFO - Output received: 09:57:35 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 09:57:35 INFO - Running post-action listener: _resource_record_post_action 09:57:35 INFO - ##### 09:57:35 INFO - ##### Running run-tests step. 09:57:35 INFO - ##### 09:57:35 INFO - Running pre-action listener: _resource_record_pre_action 09:57:35 INFO - Running main action method: run_tests 09:57:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 09:57:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 09:57:35 INFO - Python 2.7.3 09:57:35 INFO - Return code: 0 09:57:35 INFO - grabbing minidump binary from tooltool 09:57:35 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')]} 09:57:35 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 0x2ac2840>, '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 0x2a2f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a2fb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 09:57:35 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 09:57:35 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 09:57:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:57:35 INFO - Return code: 0 09:57:35 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 09:57:35 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 09:57:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 09:57:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 09:57:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 09:57:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 09:57:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 09:57:36 INFO - Return code: 0 09:57:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LFm6ntJKQnSO5ZrguWKmpw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--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 09:57:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LFm6ntJKQnSO5ZrguWKmpw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-055 --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 09:57:36 INFO - Using env: {'DISPLAY': ':0', 09:57:36 INFO - 'HOME': '/home/cltbld', 09:57:36 INFO - 'LANG': 'en_US.UTF-8', 09:57:36 INFO - 'LANGUAGE': 'en_US:en', 09:57:36 INFO - 'LOGNAME': 'cltbld', 09:57:36 INFO - 'MAIL': '/var/mail/cltbld', 09:57:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:57:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 09:57:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:36 INFO - 'MOZ_NO_REMOTE': '1', 09:57:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:57:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:36 INFO - 'NO_EM_RESTART': '1', 09:57:36 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:57:36 INFO - 'PWD': '/builds/slave/test-pgo', 09:57:36 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 09:57:36 INFO - 'SHELL': '/bin/bash', 09:57:36 INFO - 'SHLVL': '1', 09:57:36 INFO - 'TERM': 'linux', 09:57:36 INFO - 'TMOUT': '86400', 09:57:36 INFO - 'USER': 'cltbld', 09:57:36 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1452272963.565224-219127935', 09:57:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:36 INFO - '_': '/tools/buildbot/bin/python'} 09:57:36 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LFm6ntJKQnSO5ZrguWKmpw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--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 09:57:36 INFO - mozversion application_buildid: 20160108073153 09:57:36 INFO - mozversion application_changeset: 3f780f4b14acab29b16bc4141a44180a8af9dd08 09:57:36 INFO - mozversion application_display_name: Nightly 09:57:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:57:36 INFO - mozversion application_name: Firefox 09:57:36 INFO - mozversion application_remotingname: firefox 09:57:36 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:57:36 INFO - mozversion application_vendor: Mozilla 09:57:36 INFO - mozversion application_version: 46.0a1 09:57:36 INFO - mozversion platform_buildid: 20160108073153 09:57:36 INFO - mozversion platform_changeset: 3f780f4b14acab29b16bc4141a44180a8af9dd08 09:57:36 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:57:36 INFO - mozversion platform_version: 46.0a1 09:57:36 INFO - using testdate: 1452275856 09:57:36 INFO - actual date: 1452275856 09:57:36 INFO - starting webserver on 'localhost:49318' 09:57:36 INFO - SUITE-START | Running 3 tests 09:57:36 INFO - TEST-START | dromaeo_css 09:57:36 INFO - operating with platform_type : linux_ 09:57:36 INFO - Initialising browser for dromaeo_css test... 09:57:36 INFO - TEST-INFO | started process 28709 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpug37yn/profile http://localhost:49318/getInfo.html) 09:57:40 INFO - PROCESS | 28709 | __metrics Screen width/height:1600/1200 09:57:40 INFO - PROCESS | 28709 | colorDepth:24 09:57:40 INFO - PROCESS | 28709 | Browser inner width/height: 1024/697 09:57:40 INFO - PROCESS | 28709 | __metrics 09:57:40 INFO - PROCESS | 28709 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 09:57:41 INFO - PROCESS | 28709 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:57:41 INFO - TEST-INFO | 28709: exit 0 09:57:41 INFO - Browser initialized. 09:57:41 INFO - Running cycle 1/1 for dromaeo_css test... 09:57:41 INFO - TEST-INFO | started process 28804 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpug37yn/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:57:53 INFO - PROCESS | 28804 | RSS: Main: 148795392 09:57:53 INFO - PROCESS | 28804 | 09:58:45 INFO - PROCESS | 28804 | 1452275925200 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] 10:00:53 INFO - PROCESS | 28804 | Cycle 1(1): loaded http://localhost:49318/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49318/tests/dromaeo/cssquery-ext.html) 10:00:54 INFO - PROCESS | 28804 | RSS: Main: 268701696 10:00:54 INFO - PROCESS | 28804 | 10:03:56 INFO - PROCESS | 28804 | Cycle 1(1): loaded http://localhost:49318/tests/dromaeo/cssquery-ext.html (next: http://localhost:49318/tests/dromaeo/cssquery-jquery.html) 10:03:57 INFO - PROCESS | 28804 | RSS: Main: 233385984 10:03:57 INFO - PROCESS | 28804 | 10:06:59 INFO - PROCESS | 28804 | Cycle 1(1): loaded http://localhost:49318/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49318/tests/dromaeo/cssquery-mootools.html) 10:07:00 INFO - PROCESS | 28804 | RSS: Main: 240971776 10:07:00 INFO - PROCESS | 28804 | 10:10:02 INFO - PROCESS | 28804 | Cycle 1(1): loaded http://localhost:49318/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49318/tests/dromaeo/cssquery-prototype.html) 10:10:02 INFO - PROCESS | 28804 | RSS: Main: 211439616 10:10:02 INFO - PROCESS | 28804 | 10:13:05 INFO - PROCESS | 28804 | Cycle 1(1): loaded http://localhost:49318/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49318/tests/dromaeo/cssquery-yui.html) 10:13:05 INFO - PROCESS | 28804 | RSS: Main: 218505216 10:13:05 INFO - PROCESS | 28804 | 10:16:08 INFO - PROCESS | 28804 | Cycle 1(1): loaded http://localhost:49318/tests/dromaeo/cssquery-yui.html (next: http://localhost:49318/tests/dromaeo/cssquery-dojo.html) 10:16:08 INFO - PROCESS | 28804 | RSS: Main: 259452928 10:16:08 INFO - PROCESS | 28804 | 10:16:08 INFO - PROCESS | 28804 | __start_tp_report 10:16:08 INFO - PROCESS | 28804 | _x_x_mozilla_page_load 10:16:08 INFO - PROCESS | 28804 | _x_x_mozilla_page_load_details 10:16:08 INFO - PROCESS | 28804 | |i|pagename|runs| 10:16:08 INFO - PROCESS | 28804 | |0;dojo.html;3081.106479121055;3126.687331266875;3136.4197623439663;3146.653868074513;3162.5098109792975;4956.7025978441225;5021.874453138674;5026.623003274751;5042.773075211615;5075.9238611420815;4941.851744447663;4992.525710057548;5053.873653158673;5069.518395752407;5081.7459127043685;4575.062112266994;4576.54234576543;4626;4761.59526440253;4800.615950723934;4762.523747625244;4797;4815.5906747926465;4850.563449289563;4863.1732605457155;4530.773461326937;4591.977040114778;4613.331066995283;4683.508231635663;4806.182948898678;4635.884102897455;4649.418822647169;4664.463586687507;4683.086798074377;4699.718016918961;4605.102005109005;4632.629389648854;4651.046535460257;4654.162250794856;4691.460482044575;4843.75781210938;4894.388201474816;4943.8516844494725;4958.305837182797;5009.323741294915;5370.382406023318;5375.408705042442;5376.327959005124;5380.596455265871;5387.973060134714;5377.623566350357;5418.268533747933;5421.9457805421835;5458.699771512565;5468.7539060742365;4972.5276098770555;5051.065552872694;5063.063333283354;5081.364829396362;5167.121589329823;5476.370217424967;5502.9174562381595;5519.558435325164;5519.586031047687;5567.3040869891265;5322.893542129135;5328.040952628564;5337.839864804062;5346.893062138735;5347.331583552056;5317.627766056339;5428.240046393508;5433.429489903582;5454.781808727606;5567.220589117527;5337.066013447631;5338.6529875558745;5343.038253114477;5347.358317001985;5365.812196573102;5317.1492561190025;5332.0004998125705;5332.226827110047;5334.759935802898;5336.066188417011;4193.056562273464;4218.0720241546815;4276.422682937826;4280.914381712349;4316.482022157361;3806.657400833938;3817.923641527154;3843.26977874203;3848.5958974307296;3887.922241555153;4955.157623204064;5050.267711181858;5102.617303702237;5121.308623335876;5169.922451163236;5335.306410166653;5346.358436987586;5428.158635411518;5492.697901615449;5537.778488860481;5069.03688299222;5095.414027386824;5102.719350435762;5116.872078198075;5151.7166555839785;4519.615832654195;4674;4674.97662511692;4686.250199967989;4696.976515117471;5513.062779327524;5540.972295138579;5546.195801608744;5675.318961724537;5688.089905615165;5436.700981446058;5439.966406382775;5447.53695935834;5458.0721277382145;5483.616146869681;5585.385607583082;5621.409751975983;5634.549236061187;5635.6618602883955;5635.718214089361;5201.836408888435;5275.630705850554;5362.410134885237;5365.034293827149;5453.563714902878;5523.309586301712;5526.972365138148;5528.336599607912;5552.888942221214;5566.638168519034;5323.760430780701;5384.946150538444;5387.81142660005;5398.433164517669;5449.209864569536;5181.326427564392;5232.686038837682;5295.920561191509;5300.1254792958725;5392.595555333444;5258.447862974333;5259.21111833228;5260.342457192851;5266.815661451831;5288.576913846806;5347.51872331492;5355.678659280456;5355.785768569213;5378.112611419072;5426.647267927572;5135.050015747099;5187.2478490619405;5213.426523082382;5248.685078895279;5315.5216030555885 10:16:08 INFO - PROCESS | 28804 | |1;ext.html;513.0457349330247;547.2338725783904;557.8521691751687;576.2566289486562;578.1414599320009;27454.5881811773;28031.43937121259;34565.481517777254;34916.65083349166;34952.12619684503;37411;37758.622413775855;37808.43287350685;37813.62186378135;37838.02700716419;7327.12074551052;8341.37439692024;8494.617742201584;8542.572871356439;8543.530105844176;7338.706451741924;7484.850302993937;7491.325780679737;10020.448875311855;10257.128144107759;9861.901380986206;9991.100800927916;10038.849417258747;10047.045530674573;10054.648087316946;9862.45756483393;9926.751831204205;9946.502674866228;9946.65186718465;9947.80104397908;7468.066491688539;7669;7671.194524574951;7672.578008209546;9974.850377244347;35237.64762352369;35622.643773562195;35630.82184589087;35633.64366356329;35713.46429803555;3225.59680039995;3252.008137518056;3325.068980685412;3649.1059690375764;3694.4458331250257;26163;26556;26827.195184144508;27382.45235095307;27387.45225095507;3796.1588629514663;3846.9230615387814;3951.9012024699614;3954.1498577805623;4101.159262351211;275603;276908;276923;277058.6147069272;277246;55327.72336138294;55585.44414555802;55622.72188639031;55657.72171139199;55663.72168139214;57682.42317576854;57883.71058144767;57952.71023644939;57966.420335796945;57979.71010144922;14045.157290562394;14141.434342626386;14146.504872329419;14168;14175;10918.50866711;10935;10948.4525773711;10948.835767463494;10966.616168434226;17488;17872.821271787117;18274.45176644703;18289;18333.7249941251;7376.889346659805;7553.282438168365;7565.319121279112;7590.316871481483;7623.616420558201;913.1872633356318;1035.8187317219456;1037.227265687068;1070.9785804284027;1080.524569189554;25970.610440843404;26276.343091422867;26421;27845.860770696017;28681;968.704545113747;1015.817152912468;1058.2433560004479;1059.4332032362804;1137.0960086730904;12997.675058123434;13165.60503184906;13168.868311316955;14982.75258711202;15260.160691161871;249203;251748;252286;252768;253133;47005.5299447008;47296.290555641695;47306.76346618245;47307;47403.762981184875;1170.9531618735325;1197.8143387775083;1236.1223531292703;1314.9605511834661;1354.2619272496513;25312;25432.491350173263;25609.359766006;25680.357991050372;25864.8706756465;36386.63613363833;36622.63377366299;36743.81628091842;36811.63188368082;37292.440613391365;183058.0847095756;305088;306566;373753;384013;27983.740731666716;27983.860080699465;28009.01968431095;28211.43577128487;28641.856790715912;36461.45307820438;37773.62226377701;38148.427773582865;38354;38548.80725596354;34170.658293416745;34726.82636586801;35605.82197088998;35647;36347.81826090853;31795.36409271848;32306.83846580752;32347.19132021718;32350.352992939537;33471.49792753159;32973.34053318968;34761.82619086889;35824.46263306105;35889.64110358863;35978;27240.455190895675;28874;29351.55972660369;29376.11871643854;29544.67048982758;22792;24680;24751.50496990014;24974;25074.62388064144 10:16:08 INFO - PROCESS | 28804 | |2;jquery.html;353.7583083377345;355.1813070871641;358.2423174984906;360.25427365353727;360.65377237851663;13565.45738170472;14088.084274522149;16145.434909778145;16168.91915540422;17068.658626827455;14876.925615371909;14923.850761492382;14950.401983920658;14961.40154393823;15103.62240943977;4957.157283261836;5058.215976523636;5149.948500515003;5151.974240128794;5157.226416037587;3709.7959612221316;3869.3808990561515;5090.083784918713;5117.462666420028;5353.3843607985;5322.893542129174;5340.732963351837;5354.303940487731;5366.838994830161;5379.515843574078;5753.769849206027;5791.333996590382;5798.5071268941765;5799.710014499258;5801.6519008859605;4930.235813448921;5108.386993560796;5154.793808247666;5160.251763494272;5169.663971841818;12749.426275817517;12903.935480322632;14084.577462676034;19678.311259105863;19686.507837304038;1978.544934665035;2035.6132334856477;2117.4706323419146;2140.65749480084;2423.6364545318165;8983.416077954913;9037.457752534869;9313.813723725556;9330.206932410752;9616.278779091526;1737.5656085978505;1794.6231291428815;1820.9817901820945;1845.9815401845945;1878.7088001359812;53702.46297537014;54471.72764136154;54992;55227.72386138044;55553.72223138899;9709.27180461454;9719.222462203006;9729.56216970238;9777;9784.119429251401;12383.62849114528;12384.133110682345;12397.93801030989;12401.25592464455;12415.44130514129;6698.129243198353;6755.459563235027;6774.42417394527;6811.3869751721595;6821.69302381394;6402.615843049339;6408.359164083555;6420.357964203542;6444.645544495098;6462.063000864849;3949.7037722170953;4136.710430269853;4198.64311533517;4211.831526738957;4215.072684009513;1720.423658074559;1758.87687861851;1831.423101722953;1833.1567478959828;1846.2799508191815;428.08390045303076;429.63910315335266;882.6734108379941;975.6926568131158;1023.902729240721;9371.203447706885;10115.190784737204;10678.359298442118;10783.892161078445;10989.395583242838;455.7971702592381;461.76911544227886;463.3998971332133;471.07433892401593;489.94120705515564;5622.493975542221;5634.887302254014;5877.089051197071;5966.910496342558;5997.100434934795;343107;348139;523257;560595;575964;65507;66886.66556667186;68399.65800171068;71836;75822;467.53013221712644;490.51194061907916;493.89875075608694;494.9356583644103;494.93813273340834;8324.916750832414;9993.750156245862;10224.642137525449;10326.225533084898;10365.429901355497;32470.188245293113;32550.83724581362;32704;32973.01080967575;33089.33821323608;37572.812135940236;38975.220495590496;39196.216075678894;39305;39990.80004599958;7077.938309253653;7288.271172882669;7368.189499155196;7378.704851805867;7438.851222975402;10418.322809017389;10824.56701731922;11071;11248.94375528117;11307.095432365555;8386.790330241793;9589.728057675275;9791.657291994747;9828.459434731158;10044.849327259952;9444.574994125143;9523.714288571355;9562.70019696388;9722.173615242784;9723.076307750753;9593.760155996157;9640.614375424904;9921.780566016725;10230.795384092127;10291.897081029094;7347.26527347261;7469.290417410337;7510.173880873209;7582.090149182133;7596.468247222862;8115.75652730419;9707.563159657691;9733.367331123454;9891.208703303575;9901.455419951972 10:16:08 INFO - PROCESS | 28804 | |3;mootools.html;1278.9488420463183;1419.7870319452081;1423.5800438870533;1568.552962405714;1760.9119544022788;6796.558223715461;7356.337929586336;7482.064741907262;7491.737789177379;7534.246575342463;7302.3427891489755;7394.371478424327;7413.740519081834;7448.851022979537;7453.515521491099;1975.1901720294682;2018.9394318170478;2020.333290014299;2234.7430045544725;2261.061659411342;2232.944176395587;2295.724513058427;2296.816254699628;2299.482616411311;2301.1945818963395;2159.5356998245375;2187.332863476639;2199.098369668436;2199.7580266170708;2200.2959053103014;2197.165077270627;2224.1992882562263;2225.1655629139073;2229.832762542816;2230.821534277262;2202.933911982643;2203.5703037907615;2204.7684993075654;2205.845590808644;2224.4216503709154;7282.271772822728;7296.197418283985;7324.1943386228;7383.963080184619;7389.963050184715;4490.50604433512;4553.134904368193;4555.407796986404;4586.266197408432;4595.494495605481;2953.9704602954125;3038.2404398900276;3049.5273232648974;3076.7077127672837;3105.2702614885484;990.7473594233496;1005.939643621385;1040.2198351236573;1048.0305717211625;1069.7753471770936;10278.434686092261;10280.691579252634;10290.9485452573;10313.329633573794;10333.276670633059;4116.341385378385;4126.7523948563185;4230.61924426803;4231.365295205744;4257.510386305553;8927.553622318857;8936.553172341486;8937.46375217489;8950.731478055668;9047.185753282236;4689.60138388234;4691.62467002639;4699.553542413533;4700.741459219776;4703.223968045303;4246.150769846043;4265.573442655709;4281.422008028939;4287.056847493546;4296.033392486665;3203.567518385035;3263.825022991721;3272.4600440927456;3453.447448408293;3555.36003519369;1082.626493859617;1096.0683419093866;1107.9224454288283;1116.179607988128;1116.7822274656526;1262.3372729317182;1270.3521204185931;1288.8002359634272;1292.8577856435784;1293.1336004876755;6639.800805975829;6695.497837662195;6703.363180497845;6753.831154221086;6759.290274521203;1115.4144074361025;1120.3389999900098;1127.4926283172606;1136.3295655563256;1141.720278531765;5323.387810401853;5373.946260537423;5398.271233383443;5405.270288511001;5415.756290966916;8746.34402419821;8773.42972706772;8838.337124715543;8885.955570222108;8888.377813552988;8693.391462597558;8749;8837.513936733541;8884.644614215358;8900.065493123258;7057.329553692391;7071.964640176766;7274.709011639475;7290.7083716651805;7292.124945006527;6924.896126558207;6968.233494315723;6971.755988540377;6974.337437943387;6979.8604027918145;8210.178982101981;8273.503589784632;8321.417500774887;8347.457415267989;8468.068512463748;8395.70615028471;8546.658133674831;8567.528785916835;8590.527520986405;8679.956600216958;6915.757948471779;6916.688749006407;7008.824779380557;7019.262977387505;7030.086088808423;6425.839354016187;6589.835254118685;6641.402273795382;6994.160700715946;7038.40173585251;6730.932690673227;6810.557313774589;6879.174499060145;6885.380315771605;6917.308269173042;6650.102236198051;6683.799486015428;6696.296888826603;6798.456123510206;6836.350546698056;6514.4788416925585;6516.706748196438;6529.314421985623;6540.247871494839;6571.408573228241;6056.424639659225;6151.138840562236;6179.752809887734;6216.44052035319;6218.19163508741;5937.584369094122;6009.36901625323;6024.578279520391;6034.909476357946;6054.182685337423 10:16:08 INFO - PROCESS | 28804 | |4;prototype.html;332.8252667349641;335.18717111005805;344.8051850704352;345.85128394790263;355.2185192576331;5899.321578018524;5932.644041357522;5944.078667806486;5965.761369545213;5978.521718262539;5595.104783234683;5666.490015898568;5719.685417302057;5802.477777000069;5885.941140588593;4533.478649955248;4540.659450541206;4547.567516232392;4572.634189264867;4575.954240457603;4385.254506733847;4560.133574620828;4612.723236605798;4622.930656040162;4624.97687511562;4432.3794668746405;4448.666350023761;4537.455505339364;4540.2054640437955;4542.909141817178;4533.546645335457;4539.296409056601;4540;4558.840440584564;4588.380568623226;4033.8184781684895;4044.1305119399176;4058.8376464941366;4061.756294622332;4066.044479547304;5400.189971504266;5583.972080139573;5584.246126772874;5584.329880414336;5588.050031494656;5303.655262407931;5305.681659100428;5308.0710875596615;5319.6808191508635;5324.787008519655;6217.129601855744;6217.316095229521;6217.68911554425;6225.035119556476;6227.813165605039;4451.688381813275;4464.129494748526;4464.196444639963;4470.8435204767675;4475.261581839025;6323.9051414228825;6479.35206479353;6479.708413121421;6488;6499.8700025999215;4577.267637178035;4578.793954272066;4583.037562111994;4584.862454126382;4592.402987611656;4606.424196975378;4646.930296045562;4652.697574657636;4653.395058642355;4656.976715116471;5291.788328466818;5297.841064768063;5298.231756395301;5298.576113910878;5301.0723123453245;6129.570930034944;6291.276503202099;6364.109024736541;6378.6810659467765;6379.521535884827;1593.211360376621;1613.2417763651065;1614.2332392113651;1614.5479265805593;1614.9757753633705;1084.3981590217504;1094.7591529863416;1096.9012788849043;1098.2477003252798;1118.4519585403093;5964.463198312086;5977.671228082497;5979.312379076375;5983.102534619842;5997.550183736237;6390.233172019387;6445.677716114175;6448.258450278278;6449.097126402307;6462.515311351667;5803.622764520293;5862.794802181903;5922.200502932049;6000.789972350947;6008.699565021731;3483.7387195959896;3494.423420135649;3495.965040349615;3503.369393509142;3504.176518518146;6419.2296924369375;6575.178102737158;6679.198496180489;6702.162229721285;6728.562643428161;6489.740410383626;6579.80260592183;6625.801225963229;6652.634105124264;6662.733490660319;6742.460603151638;6746.628935408599;6752.898706519406;6754.493412994045;6755.459563234929;6306.527010474141;6453.548251622341;6455.870882582416;6483.4164925156965;6483.935160648333;6380.042993551005;6391.96804015977;6400.199975003125;6411.134496842867;6415.133956915756;6727.293634168342;6734.158230221223;6741.966290168518;6742.157230346207;6742.393184613408;4393.209222339881;4462.553744625511;4470.619997300266;4474.597286244254;4480.686351955332;6497.4477169441125;6500.70746816385;6504.772332968323;6505.121808555785;6507.186601674791;6318.08387783778;6324;6327.588706734047;6330.493560515056;6334.33489483616;6169.2288463942;6312.95836187024;6315.368463153648;6321.304656487875;6331.620102793847;6195.349488303663;6205.844853878509;6207.379262073757;6265.561410701207;6275.811725648238;6295;6298.212723409574;6299.086632438362;6301.054841773587;6306;6051.334353221054;6181.289151747426;6187.597806142767;6202.255729312331;6205.2553693555255 10:16:08 INFO - PROCESS | 28804 | |5;yui.html;759.0853022108356;770.7302444144547;774.3650206830398;804.1877703519448;824.8556502612043;12503.18729282596;12516.374181290934;12612.369381530933;12614.053945954056;12617.873821261785;10776.353418794877;11483.483243254053;11687.29876207428;11711;11741.530338786439;771.7993321736346;785.8035491127218;786.4887822915123;787.4251796188786;787.4645241235958;795.1094773853292;800.8278220182659;801.1147681811573;801.3268854162502;801.4950581133877;818.2186012358184;825.591332290517;828.2421584250403;828.8135169586855;829.2992421403904;826.0871736730916;826.3182874128807;826.3926014379426;826.4049884083511;827.0984626756864;615.3139249736556;616.100493279812;616.1835567872542;616.7995401494487;617.2716194890028;10905.400202988832;10993.945030274877;11051.668449946514;11056.889431105747;11131.72170695739;11103.777924441465;11301.547938082467;11396.259243149168;11398.259113157617;11585.710357241136;9715.757106072335;9735.221182305399;9833.90166098337;9872.16086632637;9884.209263258923;3505.877294294713;3618.7466877318598;3649.4160934250394;3664.5236119304586;3677.1358730698266;41230.38154427686;43445;43555;43691.34462983058;43697.78151109224;8438.113998030118;8497.447665901696;8526.87209691855;8742.737717868475;8753.124687531195;15782.842171578137;15783.684326313409;15810.841891581167;15851.682966340608;15873.68252634964;7245.311695388929;7466.141393739681;7522.586257755766;7669.923300767033;7744.922550774533;4169.687273454503;4223.457675753196;4223.957760422418;4225.260579398593;4229.945675879319;2893.2766808297924;2909.4472050310374;2916.0960102368335;2944.484715174836;2959.0974752700204;540.1223012604518;557.4453418848271;570.7403131575123;570.9628874123251;583.2592607388593;478.4139429199203;485.96112311015037;492.7117636182873;506.501096420026;515.5901058658376;7821.413393995473;7860;8161.143079976636;8279.62741676626;8342.290905273;485.2672464578512;502.8265248489265;614.3242433323397;615.8737458820931;633.2685747961112;3795.259924314732;4298;4302.698811083194;4409.522343136081;4493.213687604656;48121.75939120282;54089.45910540923;54313.45686543084;54513.45486545163;54744.17883731747;42242;43571.78214108909;43656.34515482207;43689.56310436855;43833.78083109564;33849.167287099684;47118.29322560164;47230.76384618124;47542.74460657061;48660.5133948656;8053.959730201312;8161.428699991181;8292.502449853027;8375.664973400995;8680.956595216983;33318;33434.83282583669;33508.83245583757;34191.65808341885;34554.30891382208;40139.39790903197;41399.37900931428;41561.37657935194;41768;41808.79095604503;9964.701058968243;9967.651132210338;10532.526036328536;10681.839772403575;11078.778424431304;11938.820917686067;11942.641720748392;12108;12109.818352724893;12546.686332841751;10841.566337346418;11315.71710707206;11499.367534785333;11521.596744113916;11734.471948762155;10777.946110269399;10997.890021099687;11145.888541114486;11367.052326191033;11548.59579914699;10809.35143891369;11075.778484430428;11087.611933582286;11387.089032877184;11412.885871141183;8639.784005399915;8690.565471726262;8941.955290223506;8998.280137589109;9053.049429810038;9074.818503629758;9275.639493186589;9396.267618625001;9549.331546791658;9627 10:16:08 INFO - PROCESS | 28804 | __end_tp_report 10:16:08 INFO - PROCESS | 28804 | __start_cc_report 10:16:08 INFO - PROCESS | 28804 | _x_x_mozilla_cycle_collect,858 10:16:08 INFO - PROCESS | 28804 | __end_cc_report 10:16:08 INFO - PROCESS | 28804 | __startTimestamp1452276968482__endTimestamp 10:16:08 INFO - PROCESS | 28804 | 10:16:08 INFO - PROCESS | 28804 | ------- Summary: start ------- 10:16:08 INFO - PROCESS | 28804 | Number of tests: 6 10:16:08 INFO - PROCESS | 28804 | 10:16:08 INFO - PROCESS | 28804 | [#0] dojo.html Cycles:165 Average:5055.59 Median:5258.45 stddev:528.97 (10.1%) stddev-sans-first:507.41 10:16:08 INFO - PROCESS | 28804 | Values: 3081.1 3126.7 3136.4 3146.7 3162.5 4956.7 5021.9 5026.6 5042.8 5075.9 4941.9 4992.5 5053.9 5069.5 5081.7 4575.1 4576.5 4626.0 4761.6 4800.6 4762.5 4797.0 4815.6 4850.6 4863.2 4530.8 4592.0 4613.3 4683.5 4806.2 4635.9 4649.4 4664.5 4683.1 4699.7 4605.1 4632.6 4651.0 4654.2 4691.5 4843.8 4894.4 4943.9 4958.3 5009.3 5370.4 5375.4 5376.3 5380.6 5388.0 5377.6 5418.3 5421.9 5458.7 5468.8 4972.5 5051.1 5063.1 5081.4 5167.1 5476.4 5502.9 5519.6 5519.6 5567.3 5322.9 5328.0 5337.8 5346.9 5347.3 5317.6 5428.2 5433.4 5454.8 5567.2 5337.1 5338.7 5343.0 5347.4 5365.8 5317.1 5332.0 5332.2 5334.8 5336.1 4193.1 4218.1 4276.4 4280.9 4316.5 3806.7 3817.9 3843.3 3848.6 3887.9 4955.2 5050.3 5102.6 5121.3 5169.9 5335.3 5346.4 5428.2 5492.7 5537.8 5069.0 5095.4 5102.7 5116.9 5151.7 4519.6 4674.0 4675.0 4686.3 4697.0 5513.1 5541.0 5546.2 5675.3 5688.1 5436.7 5440.0 5447.5 5458.1 5483.6 5585.4 5621.4 5634.5 5635.7 5635.7 5201.8 5275.6 5362.4 5365.0 5453.6 5523.3 5527.0 5528.3 5552.9 5566.6 5323.8 5384.9 5387.8 5398.4 5449.2 5181.3 5232.7 5295.9 5300.1 5392.6 5258.4 5259.2 5260.3 5266.8 5288.6 5347.5 5355.7 5355.8 5378.1 5426.6 5135.1 5187.2 5213.4 5248.7 5315.5 10:16:08 INFO - PROCESS | 28804 | 10:16:08 INFO - PROCESS | 28804 | [#1] ext.html Cycles:180 Average:43448.34 Median:18398.28 stddev:74365.43 (404.2%) stddev-sans-first:74504.17 10:16:08 INFO - PROCESS | 28804 | Values: 513.0 547.2 557.9 576.3 578.1 27454.6 28031.4 34565.5 34916.7 34952.1 37411.0 37758.6 37808.4 37813.6 37838.0 7327.1 8341.4 8494.6 8542.6 8543.5 7338.7 7484.9 7491.3 10020.4 10257.1 9861.9 9991.1 10038.8 10047.0 10054.6 9862.5 9926.8 9946.5 9946.7 9947.8 7468.1 7669.0 7671.2 7672.6 9974.9 35237.6 35622.6 35630.8 35633.6 35713.5 3225.6 3252.0 3325.1 3649.1 3694.4 26163.0 26556.0 26827.2 27382.5 27387.5 3796.2 3846.9 3951.9 3954.1 4101.2 275603.0 276908.0 276923.0 277058.6 277246.0 55327.7 55585.4 55622.7 55657.7 55663.7 57682.4 57883.7 57952.7 57966.4 57979.7 14045.2 14141.4 14146.5 14168.0 14175.0 10918.5 10935.0 10948.5 10948.8 10966.6 17488.0 17872.8 18274.5 18289.0 18333.7 7376.9 7553.3 7565.3 7590.3 7623.6 913.2 1035.8 1037.2 1071.0 1080.5 25970.6 26276.3 26421.0 27845.9 28681.0 968.7 1015.8 1058.2 1059.4 1137.1 12997.7 13165.6 13168.9 14982.8 15260.2 249203.0 251748.0 252286.0 252768.0 253133.0 47005.5 47296.3 47306.8 47307.0 47403.8 1171.0 1197.8 1236.1 1315.0 1354.3 25312.0 25432.5 25609.4 25680.4 25864.9 36386.6 36622.6 36743.8 36811.6 37292.4 183058.1 305088.0 306566.0 373753.0 384013.0 27983.7 27983.9 28009.0 28211.4 28641.9 36461.5 37773.6 38148.4 38354.0 38548.8 34170.7 34726.8 35605.8 35647.0 36347.8 31795.4 32306.8 32347.2 32350.4 33471.5 32973.3 34761.8 35824.5 35889.6 35978.0 27240.5 28874.0 29351.6 29376.1 29544.7 22792.0 24680.0 24751.5 24974.0 25074.6 10:16:08 INFO - PROCESS | 28804 | 10:16:08 INFO - PROCESS | 28804 | [#2] jquery.html Cycles:180 Average:24598.36 Median:5099.24 stddev:78850.45 (1546.3%) stddev-sans-first:79050.63 10:16:08 INFO - PROCESS | 28804 | Values: 353.8 355.2 358.2 360.3 360.7 13565.5 14088.1 16145.4 16168.9 17068.7 14876.9 14923.9 14950.4 14961.4 15103.6 4957.2 5058.2 5149.9 5152.0 5157.2 3709.8 3869.4 5090.1 5117.5 5353.4 5322.9 5340.7 5354.3 5366.8 5379.5 5753.8 5791.3 5798.5 5799.7 5801.7 4930.2 5108.4 5154.8 5160.3 5169.7 12749.4 12903.9 14084.6 19678.3 19686.5 1978.5 2035.6 2117.5 2140.7 2423.6 8983.4 9037.5 9313.8 9330.2 9616.3 1737.6 1794.6 1821.0 1846.0 1878.7 53702.5 54471.7 54992.0 55227.7 55553.7 9709.3 9719.2 9729.6 9777.0 9784.1 12383.6 12384.1 12397.9 12401.3 12415.4 6698.1 6755.5 6774.4 6811.4 6821.7 6402.6 6408.4 6420.4 6444.6 6462.1 3949.7 4136.7 4198.6 4211.8 4215.1 1720.4 1758.9 1831.4 1833.2 1846.3 428.1 429.6 882.7 975.7 1023.9 9371.2 10115.2 10678.4 10783.9 10989.4 455.8 461.8 463.4 471.1 489.9 5622.5 5634.9 5877.1 5966.9 5997.1 343107.0 348139.0 523257.0 560595.0 575964.0 65507.0 66886.7 68399.7 71836.0 75822.0 467.5 490.5 493.9 494.9 494.9 8324.9 9993.8 10224.6 10326.2 10365.4 32470.2 32550.8 32704.0 32973.0 33089.3 37572.8 38975.2 39196.2 39305.0 39990.8 7077.9 7288.3 7368.2 7378.7 7438.9 10418.3 10824.6 11071.0 11248.9 11307.1 8386.8 9589.7 9791.7 9828.5 10044.8 9444.6 9523.7 9562.7 9722.2 9723.1 9593.8 9640.6 9921.8 10230.8 10291.9 7347.3 7469.3 7510.2 7582.1 7596.5 8115.8 9707.6 9733.4 9891.2 9901.5 10:16:08 INFO - PROCESS | 28804 | 10:16:08 INFO - PROCESS | 28804 | [#3] mootools.html Cycles:180 Average:5257.36 Median:6016.97 stddev:2696.38 (44.8%) stddev-sans-first:2687.35 10:16:08 INFO - PROCESS | 28804 | Values: 1278.9 1419.8 1423.6 1568.6 1760.9 6796.6 7356.3 7482.1 7491.7 7534.2 7302.3 7394.4 7413.7 7448.9 7453.5 1975.2 2018.9 2020.3 2234.7 2261.1 2232.9 2295.7 2296.8 2299.5 2301.2 2159.5 2187.3 2199.1 2199.8 2200.3 2197.2 2224.2 2225.2 2229.8 2230.8 2202.9 2203.6 2204.8 2205.8 2224.4 7282.3 7296.2 7324.2 7384.0 7390.0 4490.5 4553.1 4555.4 4586.3 4595.5 2954.0 3038.2 3049.5 3076.7 3105.3 990.7 1005.9 1040.2 1048.0 1069.8 10278.4 10280.7 10290.9 10313.3 10333.3 4116.3 4126.8 4230.6 4231.4 4257.5 8927.6 8936.6 8937.5 8950.7 9047.2 4689.6 4691.6 4699.6 4700.7 4703.2 4246.2 4265.6 4281.4 4287.1 4296.0 3203.6 3263.8 3272.5 3453.4 3555.4 1082.6 1096.1 1107.9 1116.2 1116.8 1262.3 1270.4 1288.8 1292.9 1293.1 6639.8 6695.5 6703.4 6753.8 6759.3 1115.4 1120.3 1127.5 1136.3 1141.7 5323.4 5373.9 5398.3 5405.3 5415.8 8746.3 8773.4 8838.3 8886.0 8888.4 8693.4 8749.0 8837.5 8884.6 8900.1 7057.3 7072.0 7274.7 7290.7 7292.1 6924.9 6968.2 6971.8 6974.3 6979.9 8210.2 8273.5 8321.4 8347.5 8468.1 8395.7 8546.7 8567.5 8590.5 8680.0 6915.8 6916.7 7008.8 7019.3 7030.1 6425.8 6589.8 6641.4 6994.2 7038.4 6730.9 6810.6 6879.2 6885.4 6917.3 6650.1 6683.8 6696.3 6798.5 6836.4 6514.5 6516.7 6529.3 6540.2 6571.4 6056.4 6151.1 6179.8 6216.4 6218.2 5937.6 6009.4 6024.6 6034.9 6054.2 10:16:08 INFO - PROCESS | 28804 | 10:16:08 INFO - PROCESS | 28804 | [#4] prototype.html Cycles:180 Average:5262.17 Median:5954.27 stddev:1563.81 (26.3%) stddev-sans-first:1523.80 10:16:08 INFO - PROCESS | 28804 | Values: 332.8 335.2 344.8 345.9 355.2 5899.3 5932.6 5944.1 5965.8 5978.5 5595.1 5666.5 5719.7 5802.5 5885.9 4533.5 4540.7 4547.6 4572.6 4576.0 4385.3 4560.1 4612.7 4622.9 4625.0 4432.4 4448.7 4537.5 4540.2 4542.9 4533.5 4539.3 4540.0 4558.8 4588.4 4033.8 4044.1 4058.8 4061.8 4066.0 5400.2 5584.0 5584.2 5584.3 5588.1 5303.7 5305.7 5308.1 5319.7 5324.8 6217.1 6217.3 6217.7 6225.0 6227.8 4451.7 4464.1 4464.2 4470.8 4475.3 6323.9 6479.4 6479.7 6488.0 6499.9 4577.3 4578.8 4583.0 4584.9 4592.4 4606.4 4646.9 4652.7 4653.4 4657.0 5291.8 5297.8 5298.2 5298.6 5301.1 6129.6 6291.3 6364.1 6378.7 6379.5 1593.2 1613.2 1614.2 1614.5 1615.0 1084.4 1094.8 1096.9 1098.2 1118.5 5964.5 5977.7 5979.3 5983.1 5997.6 6390.2 6445.7 6448.3 6449.1 6462.5 5803.6 5862.8 5922.2 6000.8 6008.7 3483.7 3494.4 3496.0 3503.4 3504.2 6419.2 6575.2 6679.2 6702.2 6728.6 6489.7 6579.8 6625.8 6652.6 6662.7 6742.5 6746.6 6752.9 6754.5 6755.5 6306.5 6453.5 6455.9 6483.4 6483.9 6380.0 6392.0 6400.2 6411.1 6415.1 6727.3 6734.2 6742.0 6742.2 6742.4 4393.2 4462.6 4470.6 4474.6 4480.7 6497.4 6500.7 6504.8 6505.1 6507.2 6318.1 6324.0 6327.6 6330.5 6334.3 6169.2 6313.0 6315.4 6321.3 6331.6 6195.3 6205.8 6207.4 6265.6 6275.8 6295.0 6298.2 6299.1 6301.1 6306.0 6051.3 6181.3 6187.6 6202.3 6205.3 10:16:08 INFO - PROCESS | 28804 | 10:16:08 INFO - PROCESS | 28804 | [#5] yui.html Cycles:180 Average:12780.83 Median:47386.75 stddev:14578.94 (30.8%) stddev-sans-first:14591.89 10:16:08 INFO - PROCESS | 28804 | Values: 759.1 770.7 774.4 804.2 824.9 12503.2 12516.4 12612.4 12614.1 12617.9 10776.4 11483.5 11687.3 11711.0 11741.5 771.8 785.8 786.5 787.4 787.5 795.1 800.8 801.1 801.3 801.5 818.2 825.6 828.2 828.8 829.3 826.1 826.3 826.4 826.4 827.1 615.3 616.1 616.2 616.8 617.3 10905.4 10993.9 11051.7 11056.9 11131.7 11103.8 11301.5 11396.3 11398.3 11585.7 9715.8 9735.2 9833.9 9872.2 9884.2 3505.9 3618.7 3649.4 3664.5 3677.1 41230.4 43445.0 43555.0 43691.3 43697.8 8438.1 8497.4 8526.9 8742.7 8753.1 15782.8 15783.7 15810.8 15851.7 15873.7 7245.3 7466.1 7522.6 7669.9 7744.9 4169.7 4223.5 4224.0 4225.3 4229.9 2893.3 2909.4 2916.1 2944.5 2959.1 540.1 557.4 570.7 571.0 583.3 478.4 486.0 492.7 506.5 515.6 7821.4 7860.0 8161.1 8279.6 8342.3 485.3 502.8 614.3 615.9 633.3 3795.3 4298.0 4302.7 4409.5 4493.2 48121.8 54089.5 54313.5 54513.5 54744.2 42242.0 43571.8 43656.3 43689.6 43833.8 33849.2 47118.3 47230.8 47542.7 48660.5 8054.0 8161.4 8292.5 8375.7 8681.0 33318.0 33434.8 33508.8 34191.7 34554.3 40139.4 41399.4 41561.4 41768.0 41808.8 9964.7 9967.7 10532.5 10681.8 11078.8 11938.8 11942.6 12108.0 12109.8 12546.7 10841.6 11315.7 11499.4 11521.6 11734.5 10777.9 10997.9 11145.9 11367.1 11548.6 10809.4 11075.8 11087.6 11387.1 11412.9 8639.8 8690.6 8942.0 8998.3 9053.0 9074.8 9275.6 9396.3 9549.3 9627.0 10:16:08 INFO - PROCESS | 28804 | -------- Summary: end -------- 10:16:08 INFO - PROCESS | 28804 | 10:16:09 INFO - TEST-INFO | 28804: exit 0 10:16:09 INFO - TEST-OK | dromaeo_css | took 1112569ms 10:16:09 INFO - TEST-START | kraken 10:16:09 INFO - operating with platform_type : linux_ 10:16:09 INFO - Initialising browser for kraken test... 10:16:09 INFO - TEST-INFO | started process 28990 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJ5IvlO/profile http://localhost:49318/getInfo.html) 10:16:13 INFO - PROCESS | 28990 | __metrics Screen width/height:1600/1200 10:16:13 INFO - PROCESS | 28990 | colorDepth:24 10:16:13 INFO - PROCESS | 28990 | Browser inner width/height: 1024/697 10:16:13 INFO - PROCESS | 28990 | __metrics 10:16:13 INFO - PROCESS | 28990 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 10:16:13 INFO - PROCESS | 28990 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:16:14 INFO - TEST-INFO | 28990: exit 0 10:16:14 INFO - Browser initialized. 10:16:14 INFO - Running cycle 1/1 for kraken test... 10:16:14 INFO - TEST-INFO | started process 29075 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJ5IvlO/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:16:26 INFO - PROCESS | 29075 | RSS: Main: 148754432 10:16:26 INFO - PROCESS | 29075 | 10:16:28 INFO - PROCESS | 29075 | Cycle 1(1): loaded http://localhost:49318/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49318/tests/kraken/driver.html?testName=audio-beat-detection) 10:16:29 INFO - PROCESS | 29075 | RSS: Main: 185090048 10:16:29 INFO - PROCESS | 29075 | 10:16:31 INFO - PROCESS | 29075 | Cycle 1(1): loaded http://localhost:49318/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49318/tests/kraken/driver.html?testName=audio-dft) 10:16:32 INFO - PROCESS | 29075 | RSS: Main: 175292416 10:16:32 INFO - PROCESS | 29075 | 10:16:35 INFO - PROCESS | 29075 | Cycle 1(1): loaded http://localhost:49318/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49318/tests/kraken/driver.html?testName=audio-fft) 10:16:35 INFO - PROCESS | 29075 | RSS: Main: 159088640 10:16:35 INFO - PROCESS | 29075 | 10:16:37 INFO - PROCESS | 29075 | Cycle 1(1): loaded http://localhost:49318/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49318/tests/kraken/driver.html?testName=audio-oscillator) 10:16:38 INFO - PROCESS | 29075 | RSS: Main: 162291712 10:16:38 INFO - PROCESS | 29075 | 10:16:40 INFO - PROCESS | 29075 | Cycle 1(1): loaded http://localhost:49318/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49318/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:16:41 INFO - PROCESS | 29075 | RSS: Main: 164270080 10:16:41 INFO - PROCESS | 29075 | 10:16:43 INFO - PROCESS | 29075 | Cycle 1(1): loaded http://localhost:49318/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49318/tests/kraken/driver.html?testName=imaging-darkroom) 10:16:44 INFO - PROCESS | 29075 | RSS: Main: 166084608 10:16:44 INFO - PROCESS | 29075 | 10:16:47 INFO - PROCESS | 29075 | Cycle 1(1): loaded http://localhost:49318/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49318/tests/kraken/driver.html?testName=imaging-desaturate) 10:16:48 INFO - PROCESS | 29075 | RSS: Main: 164970496 10:16:48 INFO - PROCESS | 29075 | 10:16:51 INFO - PROCESS | 29075 | Cycle 1(1): loaded http://localhost:49318/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49318/tests/kraken/driver.html?testName=json-parse-financial) 10:16:51 INFO - PROCESS | 29075 | RSS: Main: 166895616 10:16:51 INFO - PROCESS | 29075 | 10:16:53 INFO - PROCESS | 29075 | Cycle 1(1): loaded http://localhost:49318/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49318/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:16:53 INFO - PROCESS | 29075 | RSS: Main: 176197632 10:16:53 INFO - PROCESS | 29075 | 10:16:55 INFO - PROCESS | 29075 | Cycle 1(1): loaded http://localhost:49318/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49318/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:16:56 INFO - PROCESS | 29075 | RSS: Main: 175439872 10:16:56 INFO - PROCESS | 29075 | 10:16:58 INFO - PROCESS | 29075 | Cycle 1(1): loaded http://localhost:49318/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49318/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:16:58 INFO - PROCESS | 29075 | RSS: Main: 188694528 10:16:58 INFO - PROCESS | 29075 | 10:17:01 INFO - PROCESS | 29075 | Cycle 1(1): loaded http://localhost:49318/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49318/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:17:02 INFO - PROCESS | 29075 | RSS: Main: 194215936 10:17:02 INFO - PROCESS | 29075 | 10:17:04 INFO - PROCESS | 29075 | Cycle 1(1): loaded http://localhost:49318/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49318/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:17:05 INFO - PROCESS | 29075 | RSS: Main: 192958464 10:17:05 INFO - PROCESS | 29075 | 10:17:06 INFO - PROCESS | 29075 | Cycle 1(1): loaded http://localhost:49318/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49318/tests/kraken/driver.html?testName=ai-astar) 10:17:07 INFO - PROCESS | 29075 | RSS: Main: 250912768 10:17:07 INFO - PROCESS | 29075 | 10:17:07 INFO - PROCESS | 29075 | __start_tp_report 10:17:07 INFO - PROCESS | 29075 | _x_x_mozilla_page_load 10:17:07 INFO - PROCESS | 29075 | _x_x_mozilla_page_load_details 10:17:07 INFO - PROCESS | 29075 | |i|pagename|runs| 10:17:07 INFO - PROCESS | 29075 | |0;ai-astar;110;112;106;110;111;111;102;110;111;111 10:17:07 INFO - PROCESS | 29075 | |1;audio-beat-detection;152;125;154;171;126;145;161;127;165;125 10:17:07 INFO - PROCESS | 29075 | |2;audio-dft;162;165;161;160;160;163;160;164;160;160 10:17:07 INFO - PROCESS | 29075 | |3;audio-fft;71;74;91;96;71;71;73;97;91;74 10:17:07 INFO - PROCESS | 29075 | |4;audio-oscillator;95;96;138;95;96;96;138;95;96;139 10:17:07 INFO - PROCESS | 29075 | |5;imaging-gaussian-blur;110;110;110;110;110;110;110;109;110;109 10:17:07 INFO - PROCESS | 29075 | |6;imaging-darkroom;146;146;146;145;145;147;147;146;147;147 10:17:07 INFO - PROCESS | 29075 | |7;imaging-desaturate;95;95;96;95;96;96;95;95;95;96 10:17:07 INFO - PROCESS | 29075 | |8;json-parse-financial;56;57;55;56;56;56;56;65;53;53 10:17:07 INFO - PROCESS | 29075 | |9;json-stringify-tinderbox;66;67;67;67;66;67;67;67;67;68 10:17:07 INFO - PROCESS | 29075 | |10;stanford-crypto-aes;93;85;88;85;84;85;85;88;86;85 10:17:07 INFO - PROCESS | 29075 | |11;stanford-crypto-ccm;118;132;127;133;123;116;124;120;127;119 10:17:07 INFO - PROCESS | 29075 | |12;stanford-crypto-pbkdf2;146;147;158;151;154;144;159;152;156;155 10:17:07 INFO - PROCESS | 29075 | |13;stanford-crypto-sha256-iterative;68;72;70;70;69;68;69;68;69;68 10:17:07 INFO - PROCESS | 29075 | __end_tp_report 10:17:07 INFO - PROCESS | 29075 | __start_cc_report 10:17:07 INFO - PROCESS | 29075 | _x_x_mozilla_cycle_collect,944 10:17:07 INFO - PROCESS | 29075 | __end_cc_report 10:17:07 INFO - PROCESS | 29075 | __startTimestamp1452277027144__endTimestamp 10:17:07 INFO - PROCESS | 29075 | 10:17:07 INFO - PROCESS | 29075 | ------- Summary: start ------- 10:17:07 INFO - PROCESS | 29075 | Number of tests: 14 10:17:07 INFO - PROCESS | 29075 | 10:17:07 INFO - PROCESS | 29075 | [#0] ai-astar Cycles:10 Average:109.40 Median:111.00 stddev:3.06 (2.8%) stddev-sans-first:3.24 10:17:07 INFO - PROCESS | 29075 | Values: 110.0 112.0 106.0 110.0 111.0 111.0 102.0 110.0 111.0 111.0 10:17:07 INFO - PROCESS | 29075 | 10:17:07 INFO - PROCESS | 29075 | [#1] audio-beat-detection Cycles:10 Average:145.10 Median:153.00 stddev:18.10 (11.8%) stddev-sans-first:19.02 10:17:07 INFO - PROCESS | 29075 | Values: 152.0 125.0 154.0 171.0 126.0 145.0 161.0 127.0 165.0 125.0 10:17:07 INFO - PROCESS | 29075 | 10:17:07 INFO - PROCESS | 29075 | [#2] audio-dft Cycles:10 Average:161.50 Median:161.50 stddev:1.90 (1.2%) stddev-sans-first:2.01 10:17:07 INFO - PROCESS | 29075 | Values: 162.0 165.0 161.0 160.0 160.0 163.0 160.0 164.0 160.0 160.0 10:17:07 INFO - PROCESS | 29075 | 10:17:07 INFO - PROCESS | 29075 | [#3] audio-fft Cycles:10 Average:80.90 Median:82.50 stddev:11.27 (13.7%) stddev-sans-first:11.37 10:17:07 INFO - PROCESS | 29075 | Values: 71.0 74.0 91.0 96.0 71.0 71.0 73.0 97.0 91.0 74.0 10:17:07 INFO - PROCESS | 29075 | 10:17:07 INFO - PROCESS | 29075 | [#4] audio-oscillator Cycles:10 Average:108.40 Median:95.50 stddev:20.66 (21.6%) stddev-sans-first:21.34 10:17:07 INFO - PROCESS | 29075 | Values: 95.0 96.0 138.0 95.0 96.0 96.0 138.0 95.0 96.0 139.0 10:17:07 INFO - PROCESS | 29075 | 10:17:07 INFO - PROCESS | 29075 | [#5] imaging-gaussian-blur Cycles:10 Average:109.80 Median:110.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 10:17:07 INFO - PROCESS | 29075 | Values: 110.0 110.0 110.0 110.0 110.0 110.0 110.0 109.0 110.0 109.0 10:17:07 INFO - PROCESS | 29075 | 10:17:07 INFO - PROCESS | 29075 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.50 stddev:0.79 (0.5%) stddev-sans-first:0.83 10:17:07 INFO - PROCESS | 29075 | Values: 146.0 146.0 146.0 145.0 145.0 147.0 147.0 146.0 147.0 147.0 10:17:07 INFO - PROCESS | 29075 | 10:17:07 INFO - PROCESS | 29075 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 10:17:07 INFO - PROCESS | 29075 | Values: 95.0 95.0 96.0 95.0 96.0 96.0 95.0 95.0 95.0 96.0 10:17:07 INFO - PROCESS | 29075 | 10:17:07 INFO - PROCESS | 29075 | [#8] json-parse-financial Cycles:10 Average:56.30 Median:56.00 stddev:3.33 (6.0%) stddev-sans-first:3.54 10:17:07 INFO - PROCESS | 29075 | Values: 56.0 57.0 55.0 56.0 56.0 56.0 56.0 65.0 53.0 53.0 10:17:07 INFO - PROCESS | 29075 | 10:17:07 INFO - PROCESS | 29075 | [#9] json-stringify-tinderbox Cycles:10 Average:66.90 Median:67.00 stddev:0.57 (0.8%) stddev-sans-first:0.50 10:17:07 INFO - PROCESS | 29075 | Values: 66.0 67.0 67.0 67.0 66.0 67.0 67.0 67.0 67.0 68.0 10:17:07 INFO - PROCESS | 29075 | 10:17:07 INFO - PROCESS | 29075 | [#10] stanford-crypto-aes Cycles:10 Average:86.40 Median:85.50 stddev:2.67 (3.1%) stddev-sans-first:1.41 10:17:07 INFO - PROCESS | 29075 | Values: 93.0 85.0 88.0 85.0 84.0 85.0 85.0 88.0 86.0 85.0 10:17:07 INFO - PROCESS | 29075 | 10:17:07 INFO - PROCESS | 29075 | [#11] stanford-crypto-ccm Cycles:10 Average:123.90 Median:125.50 stddev:5.82 (4.6%) stddev-sans-first:5.77 10:17:07 INFO - PROCESS | 29075 | Values: 118.0 132.0 127.0 133.0 123.0 116.0 124.0 120.0 127.0 119.0 10:17:07 INFO - PROCESS | 29075 | 10:17:07 INFO - PROCESS | 29075 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.20 Median:154.50 stddev:5.16 (3.3%) stddev-sans-first:4.96 10:17:07 INFO - PROCESS | 29075 | Values: 146.0 147.0 158.0 151.0 154.0 144.0 159.0 152.0 156.0 155.0 10:17:07 INFO - PROCESS | 29075 | 10:17:07 INFO - PROCESS | 29075 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:69.00 stddev:1.29 (1.9%) stddev-sans-first:1.30 10:17:07 INFO - PROCESS | 29075 | Values: 68.0 72.0 70.0 70.0 69.0 68.0 69.0 68.0 69.0 68.0 10:17:07 INFO - PROCESS | 29075 | -------- Summary: end -------- 10:17:07 INFO - PROCESS | 29075 | 10:17:07 INFO - TEST-INFO | 29075: exit 0 10:17:08 INFO - TEST-OK | kraken | took 58834ms 10:17:08 INFO - TEST-START | v8_7 10:17:08 INFO - operating with platform_type : linux_ 10:17:08 INFO - Initialising browser for v8_7 test... 10:17:08 INFO - TEST-INFO | started process 29325 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpwUWequ/profile http://localhost:49318/getInfo.html) 10:17:12 INFO - PROCESS | 29325 | __metrics Screen width/height:1600/1200 10:17:12 INFO - PROCESS | 29325 | colorDepth:24 10:17:12 INFO - PROCESS | 29325 | Browser inner width/height: 1024/697 10:17:12 INFO - PROCESS | 29325 | __metrics 10:17:12 INFO - PROCESS | 29325 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 10:17:12 INFO - PROCESS | 29325 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:17:13 INFO - TEST-INFO | 29325: exit 0 10:17:13 INFO - Browser initialized. 10:17:13 INFO - Running cycle 1/1 for v8_7 test... 10:17:13 INFO - TEST-INFO | started process 29409 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpwUWequ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:17:24 INFO - PROCESS | 29409 | RSS: Main: 148451328 10:17:24 INFO - PROCESS | 29409 | 10:17:47 INFO - PROCESS | 29409 | Cycle 1(1): loaded http://localhost:49318/tests/v8_7/run.html (next: http://localhost:49318/tests/v8_7/run.html) 10:17:47 INFO - PROCESS | 29409 | RSS: Main: 549277696 10:17:47 INFO - PROCESS | 29409 | 10:17:47 INFO - PROCESS | 29409 | __start_tp_report 10:17:47 INFO - PROCESS | 29409 | _x_x_mozilla_page_load 10:17:47 INFO - PROCESS | 29409 | _x_x_mozilla_page_load_details 10:17:47 INFO - PROCESS | 29409 | |i|pagename|runs| 10:17:47 INFO - PROCESS | 29409 | |0;Richards;166.75004168751042 10:17:47 INFO - PROCESS | 29409 | |1;DeltaBlue;191.16803670426305 10:17:47 INFO - PROCESS | 29409 | |2;Encrypt;280.662363177098 10:17:47 INFO - PROCESS | 29409 | |3;Decrypt;5154.639175257732 10:17:47 INFO - PROCESS | 29409 | |4;RayTrace;1116.0714285714287 10:17:47 INFO - PROCESS | 29409 | |5;Earley;785.7142857142857 10:17:47 INFO - PROCESS | 29409 | |6;Boyer;12219.512195121952 10:17:47 INFO - PROCESS | 29409 | |7;RegExp;42395.833333333336 10:17:47 INFO - PROCESS | 29409 | |8;Splay;575.7052389176741 10:17:47 INFO - PROCESS | 29409 | |9;NavierStokes;4850.241545893719 10:17:47 INFO - PROCESS | 29409 | __end_tp_report 10:17:47 INFO - PROCESS | 29409 | __startTimestamp1452277067470__endTimestamp 10:17:47 INFO - PROCESS | 29409 | 10:17:47 INFO - PROCESS | 29409 | ------- Summary: start ------- 10:17:47 INFO - PROCESS | 29409 | Number of tests: 10 10:17:47 INFO - PROCESS | 29409 | 10:17:47 INFO - PROCESS | 29409 | [#0] Richards Cycles:1 Average:166.75 Median:166.75 stddev:0.00 (0.0%) 10:17:47 INFO - PROCESS | 29409 | Values: 166.8 10:17:47 INFO - PROCESS | 29409 | 10:17:47 INFO - PROCESS | 29409 | [#1] DeltaBlue Cycles:1 Average:191.17 Median:191.17 stddev:0.00 (0.0%) 10:17:47 INFO - PROCESS | 29409 | Values: 191.2 10:17:47 INFO - PROCESS | 29409 | 10:17:47 INFO - PROCESS | 29409 | [#2] Encrypt Cycles:1 Average:280.66 Median:280.66 stddev:0.00 (0.0%) 10:17:47 INFO - PROCESS | 29409 | Values: 280.7 10:17:47 INFO - PROCESS | 29409 | 10:17:47 INFO - PROCESS | 29409 | [#3] Decrypt Cycles:1 Average:5154.64 Median:5154.64 stddev:0.00 (0.0%) 10:17:47 INFO - PROCESS | 29409 | Values: 5154.6 10:17:47 INFO - PROCESS | 29409 | 10:17:47 INFO - PROCESS | 29409 | [#4] RayTrace Cycles:1 Average:1116.07 Median:1116.07 stddev:0.00 (0.0%) 10:17:47 INFO - PROCESS | 29409 | Values: 1116.1 10:17:47 INFO - PROCESS | 29409 | 10:17:47 INFO - PROCESS | 29409 | [#5] Earley Cycles:1 Average:785.71 Median:785.71 stddev:0.00 (0.0%) 10:17:47 INFO - PROCESS | 29409 | Values: 785.7 10:17:47 INFO - PROCESS | 29409 | 10:17:47 INFO - PROCESS | 29409 | [#6] Boyer Cycles:1 Average:12219.51 Median:12219.51 stddev:0.00 (0.0%) 10:17:47 INFO - PROCESS | 29409 | Values: 12219.5 10:17:47 INFO - PROCESS | 29409 | 10:17:47 INFO - PROCESS | 29409 | [#7] RegExp Cycles:1 Average:42395.83 Median:42395.83 stddev:0.00 (0.0%) 10:17:47 INFO - PROCESS | 29409 | Values: 42395.8 10:17:47 INFO - PROCESS | 29409 | 10:17:47 INFO - PROCESS | 29409 | [#8] Splay Cycles:1 Average:575.71 Median:575.71 stddev:0.00 (0.0%) 10:17:47 INFO - PROCESS | 29409 | Values: 575.7 10:17:47 INFO - PROCESS | 29409 | 10:17:47 INFO - PROCESS | 29409 | [#9] NavierStokes Cycles:1 Average:4850.24 Median:4850.24 stddev:0.00 (0.0%) 10:17:47 INFO - PROCESS | 29409 | Values: 4850.2 10:17:47 INFO - PROCESS | 29409 | -------- Summary: end -------- 10:17:47 INFO - PROCESS | 29409 | 10:17:48 INFO - TEST-INFO | 29409: exit 0 10:17:48 INFO - TEST-OK | v8_7 | took 40281ms 10:17:48 INFO - SUITE-END | took 1211s 10:17:48 INFO - Completed test suite (00:20:11) 10:17:48 INFO - Working with test: dromaeo_css 10:17:48 INFO - Generating results file: dromaeo_css 10:17:48 INFO - Working with test: kraken 10:17:48 INFO - Generating results file: kraken 10:17:48 INFO - javascript benchmark 10:17:48 INFO - Working with test: v8_7 10:17:48 INFO - Generating results file: v8_7 10:17:48 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:17:48 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 10:17:48 INFO - process_Request line: dromaeo_css 6534.13 graph.html#tests=[[72,1,35]] 10:17:48 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:17:48 INFO - process_Request line: kraken 1511.50 graph.html#tests=[[232,1,35]] 10:17:48 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:17:48 INFO - process_Request line: v8_7 20109.33 graph.html#tests=[[230,1,35]] 10:17:48 INFO - RETURN: dromaeo_css: 6534.13 10:17:48 INFO - RETURN: kraken: 1511.50 10:17:48 INFO - RETURN: v8_7: 20109.33 10:17:48 INFO - javascript benchmark 10:17:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3081.106479121055, 3126.687331266875, 3136.4197623439663, 3146.653868074513, 3162.5098109792975, 4956.7025978441225, 5021.874453138674, 5026.623003274751, 5042.773075211615, 5075.9238611420815, 4941.851744447663, 4992.525710057548, 5053.873653158673, 5069.518395752407, 5081.7459127043685, 4575.062112266994, 4576.54234576543, 4626.0, 4761.59526440253, 4800.615950723934, 4762.523747625244, 4797.0, 4815.5906747926465, 4850.563449289563, 4863.1732605457155, 4530.773461326937, 4591.977040114778, 4613.331066995283, 4683.508231635663, 4806.182948898678, 4635.884102897455, 4649.418822647169, 4664.463586687507, 4683.086798074377, 4699.718016918961, 4605.102005109005, 4632.629389648854, 4651.046535460257, 4654.162250794856, 4691.460482044575, 4843.75781210938, 4894.388201474816, 4943.8516844494725, 4958.305837182797, 5009.323741294915, 5370.382406023318, 5375.408705042442, 5376.327959005124, 5380.596455265871, 5387.973060134714, 5377.623566350357, 5418.268533747933, 5421.9457805421835, 5458.699771512565, 5468.7539060742365, 4972.5276098770555, 5051.065552872694, 5063.063333283354, 5081.364829396362, 5167.121589329823, 5476.370217424967, 5502.9174562381595, 5519.558435325164, 5519.586031047687, 5567.3040869891265, 5322.893542129135, 5328.040952628564, 5337.839864804062, 5346.893062138735, 5347.331583552056, 5317.627766056339, 5428.240046393508, 5433.429489903582, 5454.781808727606, 5567.220589117527, 5337.066013447631, 5338.6529875558745, 5343.038253114477, 5347.358317001985, 5365.812196573102, 5317.1492561190025, 5332.0004998125705, 5332.226827110047, 5334.759935802898, 5336.066188417011, 4193.056562273464, 4218.0720241546815, 4276.422682937826, 4280.914381712349, 4316.482022157361, 3806.657400833938, 3817.923641527154, 3843.26977874203, 3848.5958974307296, 3887.922241555153, 4955.157623204064, 5050.267711181858, 5102.617303702237, 5121.308623335876, 5169.922451163236, 5335.306410166653, 5346.358436987586, 5428.158635411518, 5492.697901615449, 5537.778488860481, 5069.03688299222, 5095.414027386824, 5102.719350435762, 5116.872078198075, 5151.7166555839785, 4519.615832654195, 4674.0, 4674.97662511692, 4686.250199967989, 4696.976515117471, 5513.062779327524, 5540.972295138579, 5546.195801608744, 5675.318961724537, 5688.089905615165, 5436.700981446058, 5439.966406382775, 5447.53695935834, 5458.0721277382145, 5483.616146869681, 5585.385607583082, 5621.409751975983, 5634.549236061187, 5635.6618602883955, 5635.718214089361, 5201.836408888435, 5275.630705850554, 5362.410134885237, 5365.034293827149, 5453.563714902878, 5523.309586301712, 5526.972365138148, 5528.336599607912, 5552.888942221214, 5566.638168519034, 5323.760430780701, 5384.946150538444, 5387.81142660005, 5398.433164517669, 5449.209864569536, 5181.326427564392, 5232.686038837682, 5295.920561191509, 5300.1254792958725, 5392.595555333444, 5258.447862974333, 5259.21111833228, 5260.342457192851, 5266.815661451831, 5288.576913846806, 5347.51872331492, 5355.678659280456, 5355.785768569213, 5378.112611419072, 5426.647267927572, 5135.050015747099, 5187.2478490619405, 5213.426523082382, 5248.685078895279, 5315.5216030555885], "unit": "score", "name": "dojo.html", "value": 5023.596019180664}, {"lowerIsBetter": false, "replicates": [513.0457349330247, 547.2338725783904, 557.8521691751687, 576.2566289486562, 578.1414599320009, 27454.5881811773, 28031.43937121259, 34565.481517777254, 34916.65083349166, 34952.12619684503, 37411.0, 37758.622413775855, 37808.43287350685, 37813.62186378135, 37838.02700716419, 7327.12074551052, 8341.37439692024, 8494.617742201584, 8542.572871356439, 8543.530105844176, 7338.706451741924, 7484.850302993937, 7491.325780679737, 10020.448875311855, 10257.128144107759, 9861.901380986206, 9991.100800927916, 10038.849417258747, 10047.045530674573, 10054.648087316946, 9862.45756483393, 9926.751831204205, 9946.502674866228, 9946.65186718465, 9947.80104397908, 7468.066491688539, 7669.0, 7671.194524574951, 7672.578008209546, 9974.850377244347, 35237.64762352369, 35622.643773562195, 35630.82184589087, 35633.64366356329, 35713.46429803555, 3225.59680039995, 3252.008137518056, 3325.068980685412, 3649.1059690375764, 3694.4458331250257, 26163.0, 26556.0, 26827.195184144508, 27382.45235095307, 27387.45225095507, 3796.1588629514663, 3846.9230615387814, 3951.9012024699614, 3954.1498577805623, 4101.159262351211, 275603.0, 276908.0, 276923.0, 277058.6147069272, 277246.0, 55327.72336138294, 55585.44414555802, 55622.72188639031, 55657.72171139199, 55663.72168139214, 57682.42317576854, 57883.71058144767, 57952.71023644939, 57966.420335796945, 57979.71010144922, 14045.157290562394, 14141.434342626386, 14146.504872329419, 14168.0, 14175.0, 10918.50866711, 10935.0, 10948.4525773711, 10948.835767463494, 10966.616168434226, 17488.0, 17872.821271787117, 18274.45176644703, 18289.0, 18333.7249941251, 7376.889346659805, 7553.282438168365, 7565.319121279112, 7590.316871481483, 7623.616420558201, 913.1872633356318, 1035.8187317219456, 1037.227265687068, 1070.9785804284027, 1080.524569189554, 25970.610440843404, 26276.343091422867, 26421.0, 27845.860770696017, 28681.0, 968.704545113747, 1015.817152912468, 1058.2433560004479, 1059.4332032362804, 1137.0960086730904, 12997.675058123434, 13165.60503184906, 13168.868311316955, 14982.75258711202, 15260.160691161871, 249203.0, 251748.0, 252286.0, 252768.0, 253133.0, 47005.5299447008, 47296.290555641695, 47306.76346618245, 47307.0, 47403.762981184875, 1170.9531618735325, 1197.8143387775083, 1236.1223531292703, 1314.9605511834661, 1354.2619272496513, 25312.0, 25432.491350173263, 25609.359766006, 25680.357991050372, 25864.8706756465, 36386.63613363833, 36622.63377366299, 36743.81628091842, 36811.63188368082, 37292.440613391365, 183058.0847095756, 305088.0, 306566.0, 373753.0, 384013.0, 27983.740731666716, 27983.860080699465, 28009.01968431095, 28211.43577128487, 28641.856790715912, 36461.45307820438, 37773.62226377701, 38148.427773582865, 38354.0, 38548.80725596354, 34170.658293416745, 34726.82636586801, 35605.82197088998, 35647.0, 36347.81826090853, 31795.36409271848, 32306.83846580752, 32347.19132021718, 32350.352992939537, 33471.49792753159, 32973.34053318968, 34761.82619086889, 35824.46263306105, 35889.64110358863, 35978.0, 27240.455190895675, 28874.0, 29351.55972660369, 29376.11871643854, 29544.67048982758, 22792.0, 24680.0, 24751.50496990014, 24974.0, 25074.62388064144], "unit": "score", "name": "ext.html", "value": 17433.691386848703}, {"lowerIsBetter": false, "replicates": [353.7583083377345, 355.1813070871641, 358.2423174984906, 360.25427365353727, 360.65377237851663, 13565.45738170472, 14088.084274522149, 16145.434909778145, 16168.91915540422, 17068.658626827455, 14876.925615371909, 14923.850761492382, 14950.401983920658, 14961.40154393823, 15103.62240943977, 4957.157283261836, 5058.215976523636, 5149.948500515003, 5151.974240128794, 5157.226416037587, 3709.7959612221316, 3869.3808990561515, 5090.083784918713, 5117.462666420028, 5353.3843607985, 5322.893542129174, 5340.732963351837, 5354.303940487731, 5366.838994830161, 5379.515843574078, 5753.769849206027, 5791.333996590382, 5798.5071268941765, 5799.710014499258, 5801.6519008859605, 4930.235813448921, 5108.386993560796, 5154.793808247666, 5160.251763494272, 5169.663971841818, 12749.426275817517, 12903.935480322632, 14084.577462676034, 19678.311259105863, 19686.507837304038, 1978.544934665035, 2035.6132334856477, 2117.4706323419146, 2140.65749480084, 2423.6364545318165, 8983.416077954913, 9037.457752534869, 9313.813723725556, 9330.206932410752, 9616.278779091526, 1737.5656085978505, 1794.6231291428815, 1820.9817901820945, 1845.9815401845945, 1878.7088001359812, 53702.46297537014, 54471.72764136154, 54992.0, 55227.72386138044, 55553.72223138899, 9709.27180461454, 9719.222462203006, 9729.56216970238, 9777.0, 9784.119429251401, 12383.62849114528, 12384.133110682345, 12397.93801030989, 12401.25592464455, 12415.44130514129, 6698.129243198353, 6755.459563235027, 6774.42417394527, 6811.3869751721595, 6821.69302381394, 6402.615843049339, 6408.359164083555, 6420.357964203542, 6444.645544495098, 6462.063000864849, 3949.7037722170953, 4136.710430269853, 4198.64311533517, 4211.831526738957, 4215.072684009513, 1720.423658074559, 1758.87687861851, 1831.423101722953, 1833.1567478959828, 1846.2799508191815, 428.08390045303076, 429.63910315335266, 882.6734108379941, 975.6926568131158, 1023.902729240721, 9371.203447706885, 10115.190784737204, 10678.359298442118, 10783.892161078445, 10989.395583242838, 455.7971702592381, 461.76911544227886, 463.3998971332133, 471.07433892401593, 489.94120705515564, 5622.493975542221, 5634.887302254014, 5877.089051197071, 5966.910496342558, 5997.100434934795, 343107.0, 348139.0, 523257.0, 560595.0, 575964.0, 65507.0, 66886.66556667186, 68399.65800171068, 71836.0, 75822.0, 467.53013221712644, 490.51194061907916, 493.89875075608694, 494.9356583644103, 494.93813273340834, 8324.916750832414, 9993.750156245862, 10224.642137525449, 10326.225533084898, 10365.429901355497, 32470.188245293113, 32550.83724581362, 32704.0, 32973.01080967575, 33089.33821323608, 37572.812135940236, 38975.220495590496, 39196.216075678894, 39305.0, 39990.80004599958, 7077.938309253653, 7288.271172882669, 7368.189499155196, 7378.704851805867, 7438.851222975402, 10418.322809017389, 10824.56701731922, 11071.0, 11248.94375528117, 11307.095432365555, 8386.790330241793, 9589.728057675275, 9791.657291994747, 9828.459434731158, 10044.849327259952, 9444.574994125143, 9523.714288571355, 9562.70019696388, 9722.173615242784, 9723.076307750753, 9593.760155996157, 9640.614375424904, 9921.780566016725, 10230.795384092127, 10291.897081029094, 7347.26527347261, 7469.290417410337, 7510.173880873209, 7582.090149182133, 7596.468247222862, 8115.75652730419, 9707.563159657691, 9733.367331123454, 9891.208703303575, 9901.455419951972], "unit": "score", "name": "jquery.html", "value": 7226.688632561872}, {"lowerIsBetter": false, "replicates": [1278.9488420463183, 1419.7870319452081, 1423.5800438870533, 1568.552962405714, 1760.9119544022788, 6796.558223715461, 7356.337929586336, 7482.064741907262, 7491.737789177379, 7534.246575342463, 7302.3427891489755, 7394.371478424327, 7413.740519081834, 7448.851022979537, 7453.515521491099, 1975.1901720294682, 2018.9394318170478, 2020.333290014299, 2234.7430045544725, 2261.061659411342, 2232.944176395587, 2295.724513058427, 2296.816254699628, 2299.482616411311, 2301.1945818963395, 2159.5356998245375, 2187.332863476639, 2199.098369668436, 2199.7580266170708, 2200.2959053103014, 2197.165077270627, 2224.1992882562263, 2225.1655629139073, 2229.832762542816, 2230.821534277262, 2202.933911982643, 2203.5703037907615, 2204.7684993075654, 2205.845590808644, 2224.4216503709154, 7282.271772822728, 7296.197418283985, 7324.1943386228, 7383.963080184619, 7389.963050184715, 4490.50604433512, 4553.134904368193, 4555.407796986404, 4586.266197408432, 4595.494495605481, 2953.9704602954125, 3038.2404398900276, 3049.5273232648974, 3076.7077127672837, 3105.2702614885484, 990.7473594233496, 1005.939643621385, 1040.2198351236573, 1048.0305717211625, 1069.7753471770936, 10278.434686092261, 10280.691579252634, 10290.9485452573, 10313.329633573794, 10333.276670633059, 4116.341385378385, 4126.7523948563185, 4230.61924426803, 4231.365295205744, 4257.510386305553, 8927.553622318857, 8936.553172341486, 8937.46375217489, 8950.731478055668, 9047.185753282236, 4689.60138388234, 4691.62467002639, 4699.553542413533, 4700.741459219776, 4703.223968045303, 4246.150769846043, 4265.573442655709, 4281.422008028939, 4287.056847493546, 4296.033392486665, 3203.567518385035, 3263.825022991721, 3272.4600440927456, 3453.447448408293, 3555.36003519369, 1082.626493859617, 1096.0683419093866, 1107.9224454288283, 1116.179607988128, 1116.7822274656526, 1262.3372729317182, 1270.3521204185931, 1288.8002359634272, 1292.8577856435784, 1293.1336004876755, 6639.800805975829, 6695.497837662195, 6703.363180497845, 6753.831154221086, 6759.290274521203, 1115.4144074361025, 1120.3389999900098, 1127.4926283172606, 1136.3295655563256, 1141.720278531765, 5323.387810401853, 5373.946260537423, 5398.271233383443, 5405.270288511001, 5415.756290966916, 8746.34402419821, 8773.42972706772, 8838.337124715543, 8885.955570222108, 8888.377813552988, 8693.391462597558, 8749.0, 8837.513936733541, 8884.644614215358, 8900.065493123258, 7057.329553692391, 7071.964640176766, 7274.709011639475, 7290.7083716651805, 7292.124945006527, 6924.896126558207, 6968.233494315723, 6971.755988540377, 6974.337437943387, 6979.8604027918145, 8210.178982101981, 8273.503589784632, 8321.417500774887, 8347.457415267989, 8468.068512463748, 8395.70615028471, 8546.658133674831, 8567.528785916835, 8590.527520986405, 8679.956600216958, 6915.757948471779, 6916.688749006407, 7008.824779380557, 7019.262977387505, 7030.086088808423, 6425.839354016187, 6589.835254118685, 6641.402273795382, 6994.160700715946, 7038.40173585251, 6730.932690673227, 6810.557313774589, 6879.174499060145, 6885.380315771605, 6917.308269173042, 6650.102236198051, 6683.799486015428, 6696.296888826603, 6798.456123510206, 6836.350546698056, 6514.4788416925585, 6516.706748196438, 6529.314421985623, 6540.247871494839, 6571.408573228241, 6056.424639659225, 6151.138840562236, 6179.752809887734, 6216.44052035319, 6218.19163508741, 5937.584369094122, 6009.36901625323, 6024.578279520391, 6034.909476357946, 6054.182685337423], "unit": "score", "name": "mootools.html", "value": 4349.016483360383}, {"lowerIsBetter": false, "replicates": [332.8252667349641, 335.18717111005805, 344.8051850704352, 345.85128394790263, 355.2185192576331, 5899.321578018524, 5932.644041357522, 5944.078667806486, 5965.761369545213, 5978.521718262539, 5595.104783234683, 5666.490015898568, 5719.685417302057, 5802.477777000069, 5885.941140588593, 4533.478649955248, 4540.659450541206, 4547.567516232392, 4572.634189264867, 4575.954240457603, 4385.254506733847, 4560.133574620828, 4612.723236605798, 4622.930656040162, 4624.97687511562, 4432.3794668746405, 4448.666350023761, 4537.455505339364, 4540.2054640437955, 4542.909141817178, 4533.546645335457, 4539.296409056601, 4540.0, 4558.840440584564, 4588.380568623226, 4033.8184781684895, 4044.1305119399176, 4058.8376464941366, 4061.756294622332, 4066.044479547304, 5400.189971504266, 5583.972080139573, 5584.246126772874, 5584.329880414336, 5588.050031494656, 5303.655262407931, 5305.681659100428, 5308.0710875596615, 5319.6808191508635, 5324.787008519655, 6217.129601855744, 6217.316095229521, 6217.68911554425, 6225.035119556476, 6227.813165605039, 4451.688381813275, 4464.129494748526, 4464.196444639963, 4470.8435204767675, 4475.261581839025, 6323.9051414228825, 6479.35206479353, 6479.708413121421, 6488.0, 6499.8700025999215, 4577.267637178035, 4578.793954272066, 4583.037562111994, 4584.862454126382, 4592.402987611656, 4606.424196975378, 4646.930296045562, 4652.697574657636, 4653.395058642355, 4656.976715116471, 5291.788328466818, 5297.841064768063, 5298.231756395301, 5298.576113910878, 5301.0723123453245, 6129.570930034944, 6291.276503202099, 6364.109024736541, 6378.6810659467765, 6379.521535884827, 1593.211360376621, 1613.2417763651065, 1614.2332392113651, 1614.5479265805593, 1614.9757753633705, 1084.3981590217504, 1094.7591529863416, 1096.9012788849043, 1098.2477003252798, 1118.4519585403093, 5964.463198312086, 5977.671228082497, 5979.312379076375, 5983.102534619842, 5997.550183736237, 6390.233172019387, 6445.677716114175, 6448.258450278278, 6449.097126402307, 6462.515311351667, 5803.622764520293, 5862.794802181903, 5922.200502932049, 6000.789972350947, 6008.699565021731, 3483.7387195959896, 3494.423420135649, 3495.965040349615, 3503.369393509142, 3504.176518518146, 6419.2296924369375, 6575.178102737158, 6679.198496180489, 6702.162229721285, 6728.562643428161, 6489.740410383626, 6579.80260592183, 6625.801225963229, 6652.634105124264, 6662.733490660319, 6742.460603151638, 6746.628935408599, 6752.898706519406, 6754.493412994045, 6755.459563234929, 6306.527010474141, 6453.548251622341, 6455.870882582416, 6483.4164925156965, 6483.935160648333, 6380.042993551005, 6391.96804015977, 6400.199975003125, 6411.134496842867, 6415.133956915756, 6727.293634168342, 6734.158230221223, 6741.966290168518, 6742.157230346207, 6742.393184613408, 4393.209222339881, 4462.553744625511, 4470.619997300266, 4474.597286244254, 4480.686351955332, 6497.4477169441125, 6500.70746816385, 6504.772332968323, 6505.121808555785, 6507.186601674791, 6318.08387783778, 6324.0, 6327.588706734047, 6330.493560515056, 6334.33489483616, 6169.2288463942, 6312.95836187024, 6315.368463153648, 6321.304656487875, 6331.620102793847, 6195.349488303663, 6205.844853878509, 6207.379262073757, 6265.561410701207, 6275.811725648238, 6295.0, 6298.212723409574, 6299.086632438362, 6301.054841773587, 6306.0, 6051.334353221054, 6181.289151747426, 6187.597806142767, 6202.255729312331, 6205.2553693555255], "unit": "score", "name": "prototype.html", "value": 4758.4025893752805}, {"lowerIsBetter": false, "replicates": [759.0853022108356, 770.7302444144547, 774.3650206830398, 804.1877703519448, 824.8556502612043, 12503.18729282596, 12516.374181290934, 12612.369381530933, 12614.053945954056, 12617.873821261785, 10776.353418794877, 11483.483243254053, 11687.29876207428, 11711.0, 11741.530338786439, 771.7993321736346, 785.8035491127218, 786.4887822915123, 787.4251796188786, 787.4645241235958, 795.1094773853292, 800.8278220182659, 801.1147681811573, 801.3268854162502, 801.4950581133877, 818.2186012358184, 825.591332290517, 828.2421584250403, 828.8135169586855, 829.2992421403904, 826.0871736730916, 826.3182874128807, 826.3926014379426, 826.4049884083511, 827.0984626756864, 615.3139249736556, 616.100493279812, 616.1835567872542, 616.7995401494487, 617.2716194890028, 10905.400202988832, 10993.945030274877, 11051.668449946514, 11056.889431105747, 11131.72170695739, 11103.777924441465, 11301.547938082467, 11396.259243149168, 11398.259113157617, 11585.710357241136, 9715.757106072335, 9735.221182305399, 9833.90166098337, 9872.16086632637, 9884.209263258923, 3505.877294294713, 3618.7466877318598, 3649.4160934250394, 3664.5236119304586, 3677.1358730698266, 41230.38154427686, 43445.0, 43555.0, 43691.34462983058, 43697.78151109224, 8438.113998030118, 8497.447665901696, 8526.87209691855, 8742.737717868475, 8753.124687531195, 15782.842171578137, 15783.684326313409, 15810.841891581167, 15851.682966340608, 15873.68252634964, 7245.311695388929, 7466.141393739681, 7522.586257755766, 7669.923300767033, 7744.922550774533, 4169.687273454503, 4223.457675753196, 4223.957760422418, 4225.260579398593, 4229.945675879319, 2893.2766808297924, 2909.4472050310374, 2916.0960102368335, 2944.484715174836, 2959.0974752700204, 540.1223012604518, 557.4453418848271, 570.7403131575123, 570.9628874123251, 583.2592607388593, 478.4139429199203, 485.96112311015037, 492.7117636182873, 506.501096420026, 515.5901058658376, 7821.413393995473, 7860.0, 8161.143079976636, 8279.62741676626, 8342.290905273, 485.2672464578512, 502.8265248489265, 614.3242433323397, 615.8737458820931, 633.2685747961112, 3795.259924314732, 4298.0, 4302.698811083194, 4409.522343136081, 4493.213687604656, 48121.75939120282, 54089.45910540923, 54313.45686543084, 54513.45486545163, 54744.17883731747, 42242.0, 43571.78214108909, 43656.34515482207, 43689.56310436855, 43833.78083109564, 33849.167287099684, 47118.29322560164, 47230.76384618124, 47542.74460657061, 48660.5133948656, 8053.959730201312, 8161.428699991181, 8292.502449853027, 8375.664973400995, 8680.956595216983, 33318.0, 33434.83282583669, 33508.83245583757, 34191.65808341885, 34554.30891382208, 40139.39790903197, 41399.37900931428, 41561.37657935194, 41768.0, 41808.79095604503, 9964.701058968243, 9967.651132210338, 10532.526036328536, 10681.839772403575, 11078.778424431304, 11938.820917686067, 11942.641720748392, 12108.0, 12109.818352724893, 12546.686332841751, 10841.566337346418, 11315.71710707206, 11499.367534785333, 11521.596744113916, 11734.471948762155, 10777.946110269399, 10997.890021099687, 11145.888541114486, 11367.052326191033, 11548.59579914699, 10809.35143891369, 11075.778484430428, 11087.611933582286, 11387.089032877184, 11412.885871141183, 8639.784005399915, 8690.565471726262, 8941.955290223506, 8998.280137589109, 9053.049429810038, 9074.818503629758, 9275.639493186589, 9396.267618625001, 9549.331546791658, 9627.0], "unit": "score", "name": "yui.html", "value": 5941.440944783616}], "name": "dromaeo_css", "value": 6534.12418560596}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 112.0, 106.0, 110.0, 111.0, 111.0, 102.0, 110.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 109.4}, {"lowerIsBetter": true, "replicates": [152.0, 125.0, 154.0, 171.0, 126.0, 145.0, 161.0, 127.0, 165.0, 125.0], "unit": "score", "name": "audio-beat-detection", "value": 145.1}, {"lowerIsBetter": true, "replicates": [162.0, 165.0, 161.0, 160.0, 160.0, 163.0, 160.0, 164.0, 160.0, 160.0], "unit": "score", "name": "audio-dft", "value": 161.5}, {"lowerIsBetter": true, "replicates": [71.0, 74.0, 91.0, 96.0, 71.0, 71.0, 73.0, 97.0, 91.0, 74.0], "unit": "score", "name": "audio-fft", "value": 80.9}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 138.0, 95.0, 96.0, 96.0, 138.0, 95.0, 96.0, 139.0], "unit": "score", "name": "audio-oscillator", "value": 108.4}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 109.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.8}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 145.0, 145.0, 147.0, 147.0, 146.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.2}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [56.0, 57.0, 55.0, 56.0, 56.0, 56.0, 56.0, 65.0, 53.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 56.3}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 67.0, 67.0, 66.0, 67.0, 67.0, 67.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.9}, {"lowerIsBetter": true, "replicates": [93.0, 85.0, 88.0, 85.0, 84.0, 85.0, 85.0, 88.0, 86.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.4}, {"lowerIsBetter": true, "replicates": [118.0, 132.0, 127.0, 133.0, 123.0, 116.0, 124.0, 120.0, 127.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.9}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 158.0, 151.0, 154.0, 144.0, 159.0, 152.0, 156.0, 155.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 152.2}, {"lowerIsBetter": true, "replicates": [68.0, 72.0, 70.0, 70.0, 69.0, 68.0, 69.0, 68.0, 69.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.1}], "name": "kraken", "value": 1511.5}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.75004168751042], "unit": "score", "name": "Richards", "value": 211.70609399999992}, {"lowerIsBetter": false, "replicates": [191.16803670426305], "unit": "score", "name": "DeltaBlue", "value": 345.8632580000001}, {"lowerIsBetter": false, "replicates": [280.662363177098], "unit": "score", "name": "Encrypt", "value": 948.4029029999999}, {"lowerIsBetter": false, "replicates": [5154.639175257732], "unit": "score", "name": "Decrypt", "value": 51.63911399999997}, {"lowerIsBetter": false, "replicates": [1116.0714285714287], "unit": "score", "name": "RayTrace", "value": 663.0301440000001}, {"lowerIsBetter": false, "replicates": [785.7142857142857], "unit": "score", "name": "Earley", "value": 848.2256363636362}, {"lowerIsBetter": false, "replicates": [12219.512195121952], "unit": "score", "name": "Boyer", "value": 54.540884231536886}, {"lowerIsBetter": false, "replicates": [42395.833333333336], "unit": "score", "name": "RegExp", "value": 21.48760687960689}, {"lowerIsBetter": false, "replicates": [575.7052389176741], "unit": "score", "name": "Splay", "value": 141.54986699999995}, {"lowerIsBetter": false, "replicates": [4850.241545893719], "unit": "score", "name": "NavierStokes", "value": 305.9641434262948}], "name": "v8_7", "value": 20109.328081418018}]} 10:17:48 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,35]]", "result": "20109.33"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1511.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6534.13"}}} 10:17:48 INFO - Return code: 0 10:17:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 10:17:48 INFO - # TBPL SUCCESS # 10:17:48 INFO - Running post-action listener: _resource_record_post_action 10:17:48 INFO - Running post-run listener: _resource_record_post_run 10:17:49 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 16384; Write bytes: 551141376; Read time: 36; Write time: 474452 10:17:49 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 239284224; Read time: 0; Write time: 259188 10:17:49 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 16384; Write bytes: 311857152; Read time: 36; Write time: 215264 10:17:49 INFO - Running post-run listener: _upload_blobber_files 10:17:49 INFO - Blob upload gear active. 10:17:49 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 10:17:49 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 10:17:49 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', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 10:17:49 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 Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 10:17:50 INFO - (blobuploader) - INFO - Open directory for files ... 10:17:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 10:17:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:17:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:17:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:17:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:17:51 INFO - (blobuploader) - INFO - Done attempting. 10:17:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:17:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:17:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:17:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:17:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:17:52 INFO - (blobuploader) - INFO - Done attempting. 10:17:52 INFO - (blobuploader) - INFO - Iteration through files over. 10:17:52 INFO - Return code: 0 10:17:52 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 10:17:52 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 10:17:52 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0eef94aaa68ae7f2562050721444e7772ae12cfa9d75fe034b075c9e48b140267adcb0ff23302cb90d0f930d6d19520e90f995098bfcc5f28f49a69abed98b48", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f088491f8b69d5734abc0b9ab25256e06e522c2847686135a377dd965a83bd0a6f82cca16337fc6ce63ddab96c4d8ab46b999dcf5bc57b960d168e44e8ebc65a"} 10:17:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 10:17:52 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 10:17:52 INFO - Contents: 10:17:52 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0eef94aaa68ae7f2562050721444e7772ae12cfa9d75fe034b075c9e48b140267adcb0ff23302cb90d0f930d6d19520e90f995098bfcc5f28f49a69abed98b48", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f088491f8b69d5734abc0b9ab25256e06e522c2847686135a377dd965a83bd0a6f82cca16337fc6ce63ddab96c4d8ab46b999dcf5bc57b960d168e44e8ebc65a"} 10:17:52 INFO - Copying logs to upload dir... 10:17:52 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1281.510421 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2016-01-08 10:17:51.984100) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-08 10:17:51.987443) ========= 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=82e07478c745e68b1fe4678a000001bc-1452272963.565224-219127935 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0eef94aaa68ae7f2562050721444e7772ae12cfa9d75fe034b075c9e48b140267adcb0ff23302cb90d0f930d6d19520e90f995098bfcc5f28f49a69abed98b48", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f088491f8b69d5734abc0b9ab25256e06e522c2847686135a377dd965a83bd0a6f82cca16337fc6ce63ddab96c4d8ab46b999dcf5bc57b960d168e44e8ebc65a"} build_url:https://queue.taskcluster.net/v1/task/LFm6ntJKQnSO5ZrguWKmpw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011322 build_url: 'https://queue.taskcluster.net/v1/task/LFm6ntJKQnSO5ZrguWKmpw/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/Firefox/sha512/0eef94aaa68ae7f2562050721444e7772ae12cfa9d75fe034b075c9e48b140267adcb0ff23302cb90d0f930d6d19520e90f995098bfcc5f28f49a69abed98b48", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f088491f8b69d5734abc0b9ab25256e06e522c2847686135a377dd965a83bd0a6f82cca16337fc6ce63ddab96c4d8ab46b999dcf5bc57b960d168e44e8ebc65a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-08 10:17:52.012037) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 10:17:52.012374) ========= 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=82e07478c745e68b1fe4678a000001bc-1452272963.565224-219127935 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004489 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 10:17:52.094977) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-08 10:17:52.095314) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-08 10:17:52.095615) ========= ========= Total master_lag: 0.20 =========