builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-057 starttime: 1450705663.98 results: success (0) buildid: 20151221030239 builduid: bce74d3422aa47ad80a55304e17bf571 revision: e6ba2d4a2e4930bb359f90312ef6f1ebdc34c0ac ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-21 05:47:43.978287) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-21 05:47:43.978778) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-21 05:47:43.979084) ========= 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=6b42339bb4b96cfc3b1ae7e5000001a3-1450704811.202200-114231841 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006263 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-21 05:47:44.002366) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-21 05:47:44.002685) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-21 05:47:44.016378) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 05:47:44.016880) ========= 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=6b42339bb4b96cfc3b1ae7e5000001a3-1450704811.202200-114231841 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004556 ========= master_lag: 0.11 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 05:47:44.131883) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-21 05:47:44.132170) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-21 05:47:44.132581) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 05:47:44.132853) ========= 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=6b42339bb4b96cfc3b1ae7e5000001a3-1450704811.202200-114231841 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-21 05:47:45-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2015-12-21 05:47:45 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.195520 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 05:47:44.340629) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 05:47:44.341025) ========= 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=6b42339bb4b96cfc3b1ae7e5000001a3-1450704811.202200-114231841 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017679 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 05:47:44.390462) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-21 05:47:44.390824) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e6ba2d4a2e4930bb359f90312ef6f1ebdc34c0ac --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 e6ba2d4a2e4930bb359f90312ef6f1ebdc34c0ac --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=6b42339bb4b96cfc3b1ae7e5000001a3-1450704811.202200-114231841 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-21 05:47:45,351 truncating revision to first 12 chars 2015-12-21 05:47:45,351 Setting DEBUG logging. 2015-12-21 05:47:45,351 attempt 1/10 2015-12-21 05:47:45,351 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e6ba2d4a2e49?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-21 05:47:46,043 unpacking tar archive at: mozilla-central-e6ba2d4a2e49/testing/mozharness/ program finished with exit code 0 elapsedTime=0.988010 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-21 05:47:45.391471) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-21 05:47:45.391771) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-21 05:47:45.402840) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-21 05:47:45.403178) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-21 05:47:45.403597) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2015-12-21 05:47:45.403887) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--system-bits', '64', '--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=6b42339bb4b96cfc3b1ae7e5000001a3-1450704811.202200-114231841 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:47:46 INFO - MultiFileLogger online at 20151221 05:47:46 in /builds/slave/test-pgo 05:47:46 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:47:46 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:47:46 INFO - {'append_to_log': False, 05:47:46 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:47:46 INFO - 'blob_upload_branch': 'Firefox', 05:47:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:47:46 INFO - 'branch': 'Firefox', 05:47:46 INFO - 'buildbot_json_path': 'buildprops.json', 05:47:46 INFO - 'config_files': ('talos/linux_config.py',), 05:47:46 INFO - 'default_actions': ('clobber', 05:47:46 INFO - 'read-buildbot-config', 05:47:46 INFO - 'download-and-extract', 05:47:46 INFO - 'populate-webroot', 05:47:46 INFO - 'create-virtualenv', 05:47:46 INFO - 'install', 05:47:46 INFO - 'run-tests'), 05:47:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:47:46 INFO - 'download_minidump_stackwalk': True, 05:47:46 INFO - 'download_symbols': 'ondemand', 05:47:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:47:46 INFO - 'tooltool.py': '/tools/tooltool.py', 05:47:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:47:46 INFO - '/tools/misc-python/virtualenv.py')}, 05:47:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:47:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:47:46 INFO - 'installer_path': 'installer.exe', 05:47:46 INFO - 'log_level': 'info', 05:47:46 INFO - 'log_name': 'talos', 05:47:46 INFO - 'log_to_console': True, 05:47:46 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:47:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:47:46 INFO - 'opt_config_files': (), 05:47:46 INFO - 'pip_index': False, 05:47:46 INFO - 'sps_profile': False, 05:47:46 INFO - 'sps_profile_interval': 0, 05:47:46 INFO - 'suite': 'dromaeojs-e10s', 05:47:46 INFO - 'system_bits': '64', 05:47:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:47:46 INFO - 'title': 'talos-linux64-ix-057', 05:47:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:47:46 INFO - 'use_talos_json': True, 05:47:46 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:47:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:47:46 INFO - 'work_dir': 'build'} 05:47:46 INFO - ##### 05:47:46 INFO - ##### Running clobber step. 05:47:46 INFO - ##### 05:47:46 INFO - Running pre-action listener: _resource_record_pre_action 05:47:46 INFO - Running main action method: clobber 05:47:46 INFO - rmtree: /builds/slave/test-pgo/build 05:47:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:47:46 INFO - Running post-action listener: _resource_record_post_action 05:47:46 INFO - ##### 05:47:46 INFO - ##### Running read-buildbot-config step. 05:47:46 INFO - ##### 05:47:46 INFO - Running pre-action listener: _resource_record_pre_action 05:47:46 INFO - Running main action method: read_buildbot_config 05:47:46 INFO - Using buildbot properties: 05:47:46 INFO - { 05:47:46 INFO - "project": "", 05:47:46 INFO - "product": "firefox", 05:47:46 INFO - "script_repo_revision": "production", 05:47:46 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:47:46 INFO - "repository": "", 05:47:46 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 05:47:46 INFO - "buildid": "20151221030239", 05:47:46 INFO - "stage_platform": "linux64-pgo", 05:47:46 INFO - "basedir": "/builds/slave/test-pgo", 05:47:46 INFO - "nightly_build": "True", 05:47:46 INFO - "buildnumber": 589, 05:47:46 INFO - "slavename": "talos-linux64-ix-057", 05:47:46 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:47:46 INFO - "platform": "ubuntu64_hw", 05:47:46 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:47:46 INFO - "branch": "mozilla-central", 05:47:46 INFO - "repo_path": "mozilla-central", 05:47:46 INFO - "revision": "e6ba2d4a2e4930bb359f90312ef6f1ebdc34c0ac", 05:47:46 INFO - "pgo_build": "True", 05:47:46 INFO - "builduid": "bce74d3422aa47ad80a55304e17bf571", 05:47:46 INFO - "slavebuilddir": "test" 05:47:46 INFO - } 05:47:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/R2JY63BaSd-7ZdG_XF8aag/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 05:47:46 INFO - Running post-action listener: _resource_record_post_action 05:47:46 INFO - ##### 05:47:46 INFO - ##### Running download-and-extract step. 05:47:46 INFO - ##### 05:47:46 INFO - Running pre-action listener: _resource_record_pre_action 05:47:46 INFO - Running main action method: download_and_extract 05:47:46 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:47:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:46 INFO - https://queue.taskcluster.net/v1/task/R2JY63BaSd-7ZdG_XF8aag/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:47:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R2JY63BaSd-7ZdG_XF8aag/artifacts/public/build/test_packages.json 05:47:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R2JY63BaSd-7ZdG_XF8aag/artifacts/public/build/test_packages.json 05:47:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R2JY63BaSd-7ZdG_XF8aag/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 05:47:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R2JY63BaSd-7ZdG_XF8aag/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 05:47:48 INFO - Downloaded 1302 bytes. 05:47:48 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 05:47:48 INFO - Using the following test package requirements: 05:47:48 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:47:48 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:47:48 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:47:48 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:47:48 INFO - u'jsshell-linux-x86_64.zip'], 05:47:48 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:47:48 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:47:48 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:47:48 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:47:48 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:47:48 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:47:48 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:47:48 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:47:48 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:47:48 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:47:48 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:47:48 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:47:48 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:47:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:48 INFO - https://queue.taskcluster.net/v1/task/R2JY63BaSd-7ZdG_XF8aag/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:47:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R2JY63BaSd-7ZdG_XF8aag/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:47:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R2JY63BaSd-7ZdG_XF8aag/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:47:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R2JY63BaSd-7ZdG_XF8aag/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:47:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R2JY63BaSd-7ZdG_XF8aag/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:47:49 INFO - Downloaded 23175132 bytes. 05:47:49 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 05:47:49 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:47:49 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 05:47:50 INFO - Return code: 0 05:47:50 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:47:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:50 INFO - https://queue.taskcluster.net/v1/task/R2JY63BaSd-7ZdG_XF8aag/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:47:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R2JY63BaSd-7ZdG_XF8aag/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:47:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R2JY63BaSd-7ZdG_XF8aag/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:47:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R2JY63BaSd-7ZdG_XF8aag/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:47:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R2JY63BaSd-7ZdG_XF8aag/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:47:53 INFO - Downloaded 23175132 bytes. 05:47:53 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 05:47:53 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:47:53 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 05:47:55 INFO - Return code: 0 05:47:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:55 INFO - https://queue.taskcluster.net/v1/task/R2JY63BaSd-7ZdG_XF8aag/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:47:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R2JY63BaSd-7ZdG_XF8aag/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:47:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R2JY63BaSd-7ZdG_XF8aag/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:47:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R2JY63BaSd-7ZdG_XF8aag/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:47:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R2JY63BaSd-7ZdG_XF8aag/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:47:56 INFO - Downloaded 11132277 bytes. 05:47:56 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 05:47:56 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:47:56 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 05:47:57 INFO - Return code: 0 05:47:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:57 INFO - https://queue.taskcluster.net/v1/task/R2JY63BaSd-7ZdG_XF8aag/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:47:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R2JY63BaSd-7ZdG_XF8aag/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:47:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R2JY63BaSd-7ZdG_XF8aag/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:47:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R2JY63BaSd-7ZdG_XF8aag/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:47:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R2JY63BaSd-7ZdG_XF8aag/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:48:00 INFO - Downloaded 54943274 bytes. 05:48:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/R2JY63BaSd-7ZdG_XF8aag/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:48:00 INFO - mkdir: /builds/slave/test-pgo/properties 05:48:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:48:00 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:48:00 INFO - Contents: 05:48:00 INFO - build_url:https://queue.taskcluster.net/v1/task/R2JY63BaSd-7ZdG_XF8aag/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:48:00 INFO - Running post-action listener: _resource_record_post_action 05:48:00 INFO - Running post-action listener: set_extra_try_arguments 05:48:00 INFO - ##### 05:48:00 INFO - ##### Running populate-webroot step. 05:48:00 INFO - ##### 05:48:00 INFO - Running pre-action listener: _resource_record_pre_action 05:48:00 INFO - Running main action method: populate_webroot 05:48:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:48:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:48:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:48:00 INFO - '--tppagecycles', 05:48:00 INFO - '7'], 05:48:00 INFO - 'tests': ['tsvgm']}}, 05:48:00 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:48:00 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:48:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:48:00 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:48:00 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:48:00 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:48:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:48:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:48:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:48:00 INFO - 'talos_options': ['--e10s'], 05:48:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:48:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:48:00 INFO - 'tests': ['damp', 'tps']}, 05:48:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:48:00 INFO - 'talos_options': ['--e10s'], 05:48:00 INFO - 'tests': ['damp', 'tps']}, 05:48:00 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:48:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:48:00 INFO - 'other': {'tests': ['a11yr', 05:48:00 INFO - 'ts_paint', 05:48:00 INFO - 'tpaint', 05:48:00 INFO - 'sessionrestore', 05:48:00 INFO - 'sessionrestore_no_auto_restore']}, 05:48:00 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:48:00 INFO - 'tests': ['a11yr', 05:48:00 INFO - 'ts_paint', 05:48:00 INFO - 'tpaint', 05:48:00 INFO - 'sessionrestore', 05:48:00 INFO - 'sessionrestore_no_auto_restore']}, 05:48:00 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:48:00 INFO - 'tests': ['a11yr', 05:48:00 INFO - 'ts_paint', 05:48:00 INFO - 'tpaint', 05:48:00 INFO - 'sessionrestore', 05:48:00 INFO - 'sessionrestore_no_auto_restore']}, 05:48:00 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:48:00 INFO - 'tests': ['a11yr', 05:48:00 INFO - 'ts_paint', 05:48:00 INFO - 'tpaint', 05:48:00 INFO - 'sessionrestore', 05:48:00 INFO - 'sessionrestore_no_auto_restore']}, 05:48:00 INFO - 'other_l64': {'tests': ['a11yr', 05:48:00 INFO - 'ts_paint', 05:48:00 INFO - 'tpaint', 05:48:00 INFO - 'sessionrestore', 05:48:00 INFO - 'sessionrestore_no_auto_restore']}, 05:48:00 INFO - 'other_nol64': {'tests': ['a11yr', 05:48:00 INFO - 'ts_paint', 05:48:00 INFO - 'tpaint', 05:48:00 INFO - 'sessionrestore', 05:48:00 INFO - 'sessionrestore_no_auto_restore']}, 05:48:00 INFO - 'svgr': {'tests': ['tsvgx', 05:48:00 INFO - 'tsvgr_opacity', 05:48:00 INFO - 'tart', 05:48:00 INFO - 'tscrollx', 05:48:00 INFO - 'cart']}, 05:48:00 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:48:00 INFO - 'tests': ['tsvgx', 05:48:00 INFO - 'tsvgr_opacity', 05:48:00 INFO - 'tart', 05:48:00 INFO - 'tscrollx', 05:48:00 INFO - 'cart']}, 05:48:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:48:00 INFO - 'tests': ['tp5o']}, 05:48:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:48:00 INFO - 'talos_options': ['--e10s'], 05:48:00 INFO - 'tests': ['tp5o']}, 05:48:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:48:00 INFO - 'talos_options': ['--xperf_path', 05:48:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:48:00 INFO - 'tests': ['tp5n']}, 05:48:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:48:00 INFO - 'talos_options': ['--e10s', 05:48:00 INFO - '--xperf_path', 05:48:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:48:00 INFO - 'tests': ['tp5n']}}, 05:48:00 INFO - 'talos.zip': {'path': '', 05:48:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:48:00 INFO - Running post-action listener: _resource_record_post_action 05:48:00 INFO - ##### 05:48:00 INFO - ##### Running create-virtualenv step. 05:48:00 INFO - ##### 05:48:00 INFO - Running pre-action listener: _resource_record_pre_action 05:48:00 INFO - Running main action method: create_virtualenv 05:48:00 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:48:00 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 05:48:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:48:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:48:00 INFO - Using real prefix '/usr' 05:48:00 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:48:00 INFO - Installing distribute.............................................................................................................................................................................................done. 05:48:02 INFO - Installing pip.................done. 05:48:02 INFO - Return code: 0 05:48:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:48:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:48:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:48:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:02 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 0x7fec10f45f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2f840>, '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 0x1e9c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9cb60>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1450704811.202200-114231841', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:48:02 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 05:48:02 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 05:48:02 INFO - Using env: {'DISPLAY': ':0', 05:48:02 INFO - 'HOME': '/home/cltbld', 05:48:02 INFO - 'LANG': 'en_US.UTF-8', 05:48:02 INFO - 'LANGUAGE': 'en_US:en', 05:48:02 INFO - 'LOGNAME': 'cltbld', 05:48:02 INFO - 'MAIL': '/var/mail/cltbld', 05:48:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:02 INFO - 'MOZ_NO_REMOTE': '1', 05:48:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:02 INFO - 'NO_EM_RESTART': '1', 05:48:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:48:02 INFO - 'PWD': '/builds/slave/test-pgo', 05:48:02 INFO - 'SHELL': '/bin/bash', 05:48:02 INFO - 'SHLVL': '1', 05:48:02 INFO - 'TERM': 'linux', 05:48:02 INFO - 'TMOUT': '86400', 05:48:02 INFO - 'USER': 'cltbld', 05:48:02 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1450704811.202200-114231841', 05:48:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:02 INFO - '_': '/tools/buildbot/bin/python'} 05:48:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:02 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:48:02 INFO - Cleaning up... 05:48:02 INFO - Return code: 0 05:48:02 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:48:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:48:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:48:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:02 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 0x7fec10f45f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2f840>, '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 0x1e9c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9cb60>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1450704811.202200-114231841', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:48:02 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 05:48:02 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 05:48:02 INFO - Using env: {'DISPLAY': ':0', 05:48:02 INFO - 'HOME': '/home/cltbld', 05:48:02 INFO - 'LANG': 'en_US.UTF-8', 05:48:02 INFO - 'LANGUAGE': 'en_US:en', 05:48:02 INFO - 'LOGNAME': 'cltbld', 05:48:02 INFO - 'MAIL': '/var/mail/cltbld', 05:48:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:02 INFO - 'MOZ_NO_REMOTE': '1', 05:48:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:02 INFO - 'NO_EM_RESTART': '1', 05:48:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:48:02 INFO - 'PWD': '/builds/slave/test-pgo', 05:48:02 INFO - 'SHELL': '/bin/bash', 05:48:02 INFO - 'SHLVL': '1', 05:48:02 INFO - 'TERM': 'linux', 05:48:02 INFO - 'TMOUT': '86400', 05:48:02 INFO - 'USER': 'cltbld', 05:48:02 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1450704811.202200-114231841', 05:48:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:02 INFO - '_': '/tools/buildbot/bin/python'} 05:48:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:03 INFO - Downloading/unpacking psutil>=0.7.1 05:48: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 05:48: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 05:48: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 05:48: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 05:48: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 05:48: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 05:48:04 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 05:48:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:48:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:48:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:48:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:48:04 INFO - Installing collected packages: psutil 05:48:04 INFO - Running setup.py install for psutil 05:48:05 INFO - building 'psutil._psutil_linux' extension 05:48:05 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:48:05 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:48:05 INFO - building 'psutil._psutil_posix' extension 05:48:05 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:48:05 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:48:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:48:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:48:05 INFO - Successfully installed psutil 05:48:05 INFO - Cleaning up... 05:48:05 INFO - Return code: 0 05:48:05 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:48:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:48:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:48:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:05 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 0x7fec10f45f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2f840>, '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 0x1e9c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9cb60>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1450704811.202200-114231841', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:48:05 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 05:48:05 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 05:48:05 INFO - Using env: {'DISPLAY': ':0', 05:48:05 INFO - 'HOME': '/home/cltbld', 05:48:05 INFO - 'LANG': 'en_US.UTF-8', 05:48:05 INFO - 'LANGUAGE': 'en_US:en', 05:48:05 INFO - 'LOGNAME': 'cltbld', 05:48:05 INFO - 'MAIL': '/var/mail/cltbld', 05:48:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:05 INFO - 'MOZ_NO_REMOTE': '1', 05:48:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:05 INFO - 'NO_EM_RESTART': '1', 05:48:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:48:05 INFO - 'PWD': '/builds/slave/test-pgo', 05:48:05 INFO - 'SHELL': '/bin/bash', 05:48:05 INFO - 'SHLVL': '1', 05:48:05 INFO - 'TERM': 'linux', 05:48:05 INFO - 'TMOUT': '86400', 05:48:05 INFO - 'USER': 'cltbld', 05:48:05 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1450704811.202200-114231841', 05:48:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:05 INFO - '_': '/tools/buildbot/bin/python'} 05:48:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:05 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:48: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 05:48: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 05:48: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 05:48: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 05:48: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 05:48: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 05:48:07 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:48:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:48:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:48:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:48:07 INFO - Installing collected packages: mozsystemmonitor 05:48:07 INFO - Running setup.py install for mozsystemmonitor 05:48:07 INFO - Successfully installed mozsystemmonitor 05:48:07 INFO - Cleaning up... 05:48:07 INFO - Return code: 0 05:48:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:48:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:48:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:48:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:07 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 0x7fec10f45f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2f840>, '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 0x1e9c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9cb60>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1450704811.202200-114231841', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:48:07 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 05:48:07 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 05:48:07 INFO - Using env: {'DISPLAY': ':0', 05:48:07 INFO - 'HOME': '/home/cltbld', 05:48:07 INFO - 'LANG': 'en_US.UTF-8', 05:48:07 INFO - 'LANGUAGE': 'en_US:en', 05:48:07 INFO - 'LOGNAME': 'cltbld', 05:48:07 INFO - 'MAIL': '/var/mail/cltbld', 05:48:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:07 INFO - 'MOZ_NO_REMOTE': '1', 05:48:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:07 INFO - 'NO_EM_RESTART': '1', 05:48:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:48:07 INFO - 'PWD': '/builds/slave/test-pgo', 05:48:07 INFO - 'SHELL': '/bin/bash', 05:48:07 INFO - 'SHLVL': '1', 05:48:07 INFO - 'TERM': 'linux', 05:48:07 INFO - 'TMOUT': '86400', 05:48:07 INFO - 'USER': 'cltbld', 05:48:07 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1450704811.202200-114231841', 05:48:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:07 INFO - '_': '/tools/buildbot/bin/python'} 05:48:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:07 INFO - Downloading/unpacking blobuploader==1.2.4 05:48:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:09 INFO - Downloading blobuploader-1.2.4.tar.gz 05:48:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:48:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:48:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:48:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:48:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:48:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:48:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:10 INFO - Downloading docopt-0.6.1.tar.gz 05:48:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:48:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:48:10 INFO - Installing collected packages: blobuploader, requests, docopt 05:48:10 INFO - Running setup.py install for blobuploader 05:48:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:48:10 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:48:10 INFO - Running setup.py install for requests 05:48:10 INFO - Running setup.py install for docopt 05:48:10 INFO - Successfully installed blobuploader requests docopt 05:48:10 INFO - Cleaning up... 05:48:10 INFO - Return code: 0 05:48:10 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:48:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:48:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:48:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:10 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 0x7fec10f45f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2f840>, '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 0x1e9c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9cb60>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1450704811.202200-114231841', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:48:10 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 05:48:10 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 05:48:10 INFO - Using env: {'DISPLAY': ':0', 05:48:10 INFO - 'HOME': '/home/cltbld', 05:48:10 INFO - 'LANG': 'en_US.UTF-8', 05:48:10 INFO - 'LANGUAGE': 'en_US:en', 05:48:10 INFO - 'LOGNAME': 'cltbld', 05:48:10 INFO - 'MAIL': '/var/mail/cltbld', 05:48:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:10 INFO - 'MOZ_NO_REMOTE': '1', 05:48:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:10 INFO - 'NO_EM_RESTART': '1', 05:48:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:48:10 INFO - 'PWD': '/builds/slave/test-pgo', 05:48:10 INFO - 'SHELL': '/bin/bash', 05:48:10 INFO - 'SHLVL': '1', 05:48:10 INFO - 'TERM': 'linux', 05:48:10 INFO - 'TMOUT': '86400', 05:48:10 INFO - 'USER': 'cltbld', 05:48:10 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1450704811.202200-114231841', 05:48:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:10 INFO - '_': '/tools/buildbot/bin/python'} 05:48:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:48:11 INFO - Running setup.py (path:/tmp/pip-J6F2U7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:48:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:48:11 INFO - Running setup.py (path:/tmp/pip-GXaJu4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:48:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:48:11 INFO - Running setup.py (path:/tmp/pip-4LVW9n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:48:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:48:11 INFO - Running setup.py (path:/tmp/pip-p42APq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:48:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:48:11 INFO - Running setup.py (path:/tmp/pip-bj0CRA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:48:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:48:11 INFO - Running setup.py (path:/tmp/pip-ya2nvu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:48:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:48:11 INFO - Running setup.py (path:/tmp/pip-UteR0h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:48:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:48:11 INFO - Running setup.py (path:/tmp/pip-QLvM0B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:48:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:48:11 INFO - Running setup.py (path:/tmp/pip-1viNkS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:48:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:48:11 INFO - Running setup.py (path:/tmp/pip-fIUL_X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:48:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:48:11 INFO - Running setup.py (path:/tmp/pip-lk6j8L-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:48:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:48:11 INFO - Running setup.py (path:/tmp/pip-ZNvMgZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:48:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:48:11 INFO - Running setup.py (path:/tmp/pip-9bkC5X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:48:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:48:12 INFO - Running setup.py (path:/tmp/pip-TEXO3B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:48:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:48:12 INFO - Running setup.py (path:/tmp/pip-LrncPB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:48:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:48:12 INFO - Running setup.py (path:/tmp/pip-zjUkgu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:48:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:48:12 INFO - Running setup.py (path:/tmp/pip-y_RzBU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:48:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:48:12 INFO - Running setup.py install for manifestparser 05:48:12 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:48:12 INFO - Running setup.py install for mozcrash 05:48:12 INFO - Running setup.py install for mozdebug 05:48:12 INFO - Running setup.py install for mozdevice 05:48:12 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:48:12 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:48:12 INFO - Running setup.py install for mozfile 05:48:12 INFO - Running setup.py install for mozhttpd 05:48:12 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:48:12 INFO - Running setup.py install for mozinfo 05:48:12 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:48:13 INFO - Running setup.py install for mozInstall 05:48:13 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:48:13 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:48:13 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:48:13 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:48:13 INFO - Running setup.py install for mozleak 05:48:13 INFO - Running setup.py install for mozlog 05:48:13 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:48:13 INFO - Running setup.py install for moznetwork 05:48:13 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:48:13 INFO - Running setup.py install for mozprocess 05:48:13 INFO - Running setup.py install for mozprofile 05:48:13 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:48:13 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:48:13 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:48:13 INFO - Running setup.py install for mozrunner 05:48:13 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:48:13 INFO - Running setup.py install for mozscreenshot 05:48:13 INFO - Running setup.py install for moztest 05:48:13 INFO - Running setup.py install for mozversion 05:48:14 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:48:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:48:14 INFO - Cleaning up... 05:48:14 INFO - Return code: 0 05:48:14 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:48:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:48:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:48:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:14 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 0x7fec10f45f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2f840>, '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 0x1e9c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9cb60>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1450704811.202200-114231841', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:48:14 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 05:48:14 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 05:48:14 INFO - Using env: {'DISPLAY': ':0', 05:48:14 INFO - 'HOME': '/home/cltbld', 05:48:14 INFO - 'LANG': 'en_US.UTF-8', 05:48:14 INFO - 'LANGUAGE': 'en_US:en', 05:48:14 INFO - 'LOGNAME': 'cltbld', 05:48:14 INFO - 'MAIL': '/var/mail/cltbld', 05:48:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:14 INFO - 'MOZ_NO_REMOTE': '1', 05:48:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:14 INFO - 'NO_EM_RESTART': '1', 05:48:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:48:14 INFO - 'PWD': '/builds/slave/test-pgo', 05:48:14 INFO - 'SHELL': '/bin/bash', 05:48:14 INFO - 'SHLVL': '1', 05:48:14 INFO - 'TERM': 'linux', 05:48:14 INFO - 'TMOUT': '86400', 05:48:14 INFO - 'USER': 'cltbld', 05:48:14 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1450704811.202200-114231841', 05:48:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:14 INFO - '_': '/tools/buildbot/bin/python'} 05:48:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:48:14 INFO - Running setup.py (path:/tmp/pip-5CnxtA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:48:14 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 05:48:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:48:14 INFO - Running setup.py (path:/tmp/pip-7phFsS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:48:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:48:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:48:14 INFO - Running setup.py (path:/tmp/pip-t9Mhd8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:48:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 05:48:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:48:14 INFO - Running setup.py (path:/tmp/pip-W3c_PH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:48:14 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)) 05:48:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:48:14 INFO - Running setup.py (path:/tmp/pip-SdQFuk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:48:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 05:48:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:48:14 INFO - Running setup.py (path:/tmp/pip-GtVBNw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:48:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 05:48:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:48:14 INFO - Running setup.py (path:/tmp/pip-H4FKOl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:48:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 05:48:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:48:14 INFO - Running setup.py (path:/tmp/pip-jGTZpN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:48:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 05:48:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:48:14 INFO - Running setup.py (path:/tmp/pip-wo4Vjc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:48:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 05:48:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:48:14 INFO - Running setup.py (path:/tmp/pip-A0jSKF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:48:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:48:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:48:15 INFO - Running setup.py (path:/tmp/pip-rJ4Ror-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:48:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 05:48:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:48:15 INFO - Running setup.py (path:/tmp/pip-y92fwe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:48:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 05:48:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:48:15 INFO - Running setup.py (path:/tmp/pip-t6io24-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:48:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 05:48:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:48:15 INFO - Running setup.py (path:/tmp/pip-oOJ5dl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:48:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 05:48:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:48:15 INFO - Running setup.py (path:/tmp/pip-RYZvNE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:48:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 05:48:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:48:15 INFO - Running setup.py (path:/tmp/pip-TxOmH0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:48:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 05:48:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:48:15 INFO - Running setup.py (path:/tmp/pip-BD5mOJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:48:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 05:48:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:48:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:48:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 05:48:15 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)) 05:48:15 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)) 05:48:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:48: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 05:48: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 05:48: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 05:48: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 05:48: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 05:48: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 05:48:17 INFO - Downloading blessings-1.5.1.tar.gz 05:48:17 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 05:48:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:48:17 INFO - Installing collected packages: blessings 05:48:17 INFO - Running setup.py install for blessings 05:48:17 INFO - Successfully installed blessings 05:48:17 INFO - Cleaning up... 05:48:17 INFO - Return code: 0 05:48:17 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:48:17 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:48:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:48:17 INFO - Reading from file tmpfile_stdout 05:48:17 INFO - Current package versions: 05:48:17 INFO - argparse == 1.2.1 05:48:17 INFO - blessings == 1.5.1 05:48:17 INFO - blobuploader == 1.2.4 05:48:17 INFO - docopt == 0.6.1 05:48:17 INFO - manifestparser == 1.1 05:48:17 INFO - mozInstall == 1.12 05:48:17 INFO - mozcrash == 0.16 05:48:17 INFO - mozdebug == 0.1 05:48:17 INFO - mozdevice == 0.47 05:48:17 INFO - mozfile == 1.2 05:48:17 INFO - mozhttpd == 0.7 05:48:17 INFO - mozinfo == 0.9 05:48:17 INFO - mozleak == 0.1 05:48:17 INFO - mozlog == 3.1 05:48:17 INFO - moznetwork == 0.27 05:48:17 INFO - mozprocess == 0.22 05:48:17 INFO - mozprofile == 0.28 05:48:17 INFO - mozrunner == 6.11 05:48:17 INFO - mozscreenshot == 0.1 05:48:17 INFO - mozsystemmonitor == 0.0 05:48:17 INFO - moztest == 0.7 05:48:17 INFO - mozversion == 1.4 05:48:17 INFO - psutil == 3.1.1 05:48:17 INFO - requests == 1.2.3 05:48:17 INFO - wsgiref == 0.1.2 05:48:17 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:48:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:48:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:48:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:17 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 0x7fec10f45f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2f840>, '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 0x1e9c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9cb60>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1450704811.202200-114231841', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:48:17 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 05:48:17 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 05:48:17 INFO - Using env: {'DISPLAY': ':0', 05:48:17 INFO - 'HOME': '/home/cltbld', 05:48:17 INFO - 'LANG': 'en_US.UTF-8', 05:48:17 INFO - 'LANGUAGE': 'en_US:en', 05:48:17 INFO - 'LOGNAME': 'cltbld', 05:48:17 INFO - 'MAIL': '/var/mail/cltbld', 05:48:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:17 INFO - 'MOZ_NO_REMOTE': '1', 05:48:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:17 INFO - 'NO_EM_RESTART': '1', 05:48:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:48:17 INFO - 'PWD': '/builds/slave/test-pgo', 05:48:17 INFO - 'SHELL': '/bin/bash', 05:48:17 INFO - 'SHLVL': '1', 05:48:17 INFO - 'TERM': 'linux', 05:48:17 INFO - 'TMOUT': '86400', 05:48:17 INFO - 'USER': 'cltbld', 05:48:17 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1450704811.202200-114231841', 05:48:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:17 INFO - '_': '/tools/buildbot/bin/python'} 05:48:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:48:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 05:48:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 05:48:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 05:48:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 05:48:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 05:48:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 05:48:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 05:48:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 05:48:18 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:48:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 05:48:18 INFO - Cleaning up... 05:48:18 INFO - Return code: 0 05:48:18 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 05:48:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:48:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:48:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:18 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 0x7fec10f45f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2f840>, '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 0x1e9c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9cb60>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1450704811.202200-114231841', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:48:18 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 05:48:18 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 05:48:18 INFO - Using env: {'DISPLAY': ':0', 05:48:18 INFO - 'HOME': '/home/cltbld', 05:48:18 INFO - 'LANG': 'en_US.UTF-8', 05:48:18 INFO - 'LANGUAGE': 'en_US:en', 05:48:18 INFO - 'LOGNAME': 'cltbld', 05:48:18 INFO - 'MAIL': '/var/mail/cltbld', 05:48:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:18 INFO - 'MOZ_NO_REMOTE': '1', 05:48:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:18 INFO - 'NO_EM_RESTART': '1', 05:48:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:48:18 INFO - 'PWD': '/builds/slave/test-pgo', 05:48:18 INFO - 'SHELL': '/bin/bash', 05:48:18 INFO - 'SHLVL': '1', 05:48:18 INFO - 'TERM': 'linux', 05:48:18 INFO - 'TMOUT': '86400', 05:48:18 INFO - 'USER': 'cltbld', 05:48:18 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1450704811.202200-114231841', 05:48:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:18 INFO - '_': '/tools/buildbot/bin/python'} 05:48:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:18 INFO - Downloading/unpacking jsonschema 05:48: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 05:48: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 05:48: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 05:48: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 05:48: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 05:48: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 05:48:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:48:20 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 05:48:20 INFO - Downloading/unpacking functools32 (from jsonschema) 05:48:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:20 INFO - Downloading functools32-3.2.3-2.tar.gz 05:48:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 05:48:20 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 05:48:20 INFO - warning: no files found matching '*.txt' 05:48:20 INFO - no previously-included directories found matching 'build' 05:48:20 INFO - no previously-included directories found matching 'dist' 05:48:20 INFO - no previously-included directories found matching '.git*' 05:48:20 INFO - Installing collected packages: jsonschema, functools32 05:48:20 INFO - Running setup.py install for functools32 05:48:20 INFO - warning: no files found matching '*.txt' 05:48:20 INFO - no previously-included directories found matching 'build' 05:48:20 INFO - no previously-included directories found matching 'dist' 05:48:20 INFO - no previously-included directories found matching '.git*' 05:48:20 INFO - Successfully installed jsonschema functools32 05:48:20 INFO - Cleaning up... 05:48:20 INFO - Return code: 0 05:48:20 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 05:48:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:48:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:48:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:20 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 0x7fec10f45f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2f840>, '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 0x1e9c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9cb60>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1450704811.202200-114231841', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:48:20 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 05:48:20 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 05:48:20 INFO - Using env: {'DISPLAY': ':0', 05:48:20 INFO - 'HOME': '/home/cltbld', 05:48:20 INFO - 'LANG': 'en_US.UTF-8', 05:48:20 INFO - 'LANGUAGE': 'en_US:en', 05:48:20 INFO - 'LOGNAME': 'cltbld', 05:48:20 INFO - 'MAIL': '/var/mail/cltbld', 05:48:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:20 INFO - 'MOZ_NO_REMOTE': '1', 05:48:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:20 INFO - 'NO_EM_RESTART': '1', 05:48:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:48:20 INFO - 'PWD': '/builds/slave/test-pgo', 05:48:20 INFO - 'SHELL': '/bin/bash', 05:48:20 INFO - 'SHLVL': '1', 05:48:20 INFO - 'TERM': 'linux', 05:48:20 INFO - 'TMOUT': '86400', 05:48:20 INFO - 'USER': 'cltbld', 05:48:20 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1450704811.202200-114231841', 05:48:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:20 INFO - '_': '/tools/buildbot/bin/python'} 05:48:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:20 INFO - Downloading/unpacking flake8 05:48:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:22 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:48:22 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 05:48:22 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:48:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:22 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:48:22 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 05:48:22 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:48:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:22 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 05:48:22 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:48:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 05:48:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 05:48:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:48:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:48:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:48:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:48:22 INFO - no previously-included directories found matching 'docs/_build' 05:48:23 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:48:23 INFO - Running setup.py install for pep8 05:48:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:48:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:48:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:48:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:48:23 INFO - no previously-included directories found matching 'docs/_build' 05:48:23 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 05:48:23 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:48:23 INFO - Cleaning up... 05:48:23 INFO - Return code: 0 05:48:23 INFO - Running post-action listener: _resource_record_post_action 05:48:23 INFO - Running post-action listener: _start_resource_monitoring 05:48:23 INFO - Starting resource monitoring. 05:48:23 INFO - ##### 05:48:23 INFO - ##### Running install step. 05:48:23 INFO - ##### 05:48:23 INFO - Running pre-action listener: _resource_record_pre_action 05:48:23 INFO - Running main action method: install 05:48:23 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:48:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:48:23 INFO - Reading from file tmpfile_stdout 05:48:23 INFO - Detecting whether we're running mozinstall >=1.0... 05:48:23 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:48:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:48:23 INFO - Reading from file tmpfile_stdout 05:48:23 INFO - Output received: 05:48:23 INFO - Usage: mozinstall [options] installer 05:48:23 INFO - Options: 05:48:23 INFO - -h, --help show this help message and exit 05:48:23 INFO - -d DEST, --destination=DEST 05:48:23 INFO - Directory to install application into. [default: 05:48:23 INFO - "/builds/slave/test-pgo"] 05:48:23 INFO - --app=APP Application being installed. [default: firefox] 05:48:23 INFO - mkdir: /builds/slave/test-pgo/build/application 05:48:23 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 05:48:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 05:48:39 INFO - Reading from file tmpfile_stdout 05:48:39 INFO - Output received: 05:48:39 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:48:39 INFO - Running post-action listener: _resource_record_post_action 05:48:39 INFO - ##### 05:48:39 INFO - ##### Running run-tests step. 05:48:39 INFO - ##### 05:48:39 INFO - Running pre-action listener: _resource_record_pre_action 05:48:39 INFO - Running main action method: run_tests 05:48:39 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:48:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:48:39 INFO - Python 2.7.3 05:48:39 INFO - Return code: 0 05:48:39 INFO - grabbing minidump binary from tooltool 05:48:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:48:39 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 0x1f2f840>, '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 0x1e9c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9cb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:48:39 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 05:48:39 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:48:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:48:39 INFO - Return code: 0 05:48:39 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:48:39 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:48:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:48:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:48:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:48:39 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 05:48:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 05:48:40 INFO - Return code: 0 05:48:40 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-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/R2JY63BaSd-7ZdG_XF8aag/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 05:48:40 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-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/R2JY63BaSd-7ZdG_XF8aag/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-057 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:48:40 INFO - Using env: {'DISPLAY': ':0', 05:48:40 INFO - 'HOME': '/home/cltbld', 05:48:40 INFO - 'LANG': 'en_US.UTF-8', 05:48:40 INFO - 'LANGUAGE': 'en_US:en', 05:48:40 INFO - 'LOGNAME': 'cltbld', 05:48:40 INFO - 'MAIL': '/var/mail/cltbld', 05:48:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:48:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:48:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:40 INFO - 'MOZ_NO_REMOTE': '1', 05:48:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:48:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:40 INFO - 'NO_EM_RESTART': '1', 05:48:40 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:48:40 INFO - 'PWD': '/builds/slave/test-pgo', 05:48:40 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:48:40 INFO - 'SHELL': '/bin/bash', 05:48:40 INFO - 'SHLVL': '1', 05:48:40 INFO - 'TERM': 'linux', 05:48:40 INFO - 'TMOUT': '86400', 05:48:40 INFO - 'USER': 'cltbld', 05:48:40 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1450704811.202200-114231841', 05:48:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:40 INFO - '_': '/tools/buildbot/bin/python'} 05:48:40 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-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/R2JY63BaSd-7ZdG_XF8aag/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:48:40 INFO - mozversion application_buildid: 20151221030239 05:48:40 INFO - mozversion application_changeset: e6ba2d4a2e4930bb359f90312ef6f1ebdc34c0ac 05:48:40 INFO - mozversion application_display_name: Nightly 05:48:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:48:40 INFO - mozversion application_name: Firefox 05:48:40 INFO - mozversion application_remotingname: firefox 05:48:40 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:48:40 INFO - mozversion application_vendor: Mozilla 05:48:40 INFO - mozversion application_version: 46.0a1 05:48:40 INFO - mozversion platform_buildid: 20151221030239 05:48:40 INFO - mozversion platform_changeset: e6ba2d4a2e4930bb359f90312ef6f1ebdc34c0ac 05:48:40 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:48:40 INFO - mozversion platform_version: 46.0a1 05:48:40 INFO - using testdate: 1450705720 05:48:40 INFO - actual date: 1450705720 05:48:40 INFO - starting webserver on 'localhost:57074' 05:48:40 INFO - SUITE-START | Running 3 tests 05:48:40 INFO - TEST-START | dromaeo_css 05:48:40 INFO - operating with platform_type : linux_ 05:48:40 INFO - Initialising browser for dromaeo_css test... 05:48:40 INFO - TEST-INFO | started process 4660 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcId1FD/profile http://localhost:57074/getInfo.html) 05:48:44 INFO - PROCESS | 4660 | JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 05:48:45 INFO - PROCESS | 4660 | __metrics Screen width/height:1600/1200 05:48:45 INFO - PROCESS | 4660 | colorDepth:24 05:48:45 INFO - PROCESS | 4660 | Browser inner width/height: 1024/670 05:48:45 INFO - PROCESS | 4660 | __metrics 05:48:45 INFO - PROCESS | 4660 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:48:46 INFO - TEST-INFO | 4660: exit 0 05:48:46 INFO - Browser initialized. 05:48:46 INFO - Running cycle 1/1 for dromaeo_css test... 05:48:46 INFO - TEST-INFO | started process 4794 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcId1FD/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:48:57 INFO - PROCESS | 4794 | RSS: Main: 150835200 05:48:57 INFO - PROCESS | 4794 | 05:49:47 INFO - PROCESS | 4794 | 1450705787471 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:51:56 INFO - PROCESS | 4794 | Cycle 1(1): loaded http://localhost:57074/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57074/tests/dromaeo/cssquery-ext.html) 05:51:57 INFO - PROCESS | 4794 | RSS: Main: 158175232 05:51:57 INFO - PROCESS | 4794 | 05:54:59 INFO - PROCESS | 4794 | Cycle 1(1): loaded http://localhost:57074/tests/dromaeo/cssquery-ext.html (next: http://localhost:57074/tests/dromaeo/cssquery-jquery.html) 05:54:59 INFO - PROCESS | 4794 | RSS: Main: 153862144 05:54:59 INFO - PROCESS | 4794 | 05:58:01 INFO - PROCESS | 4794 | Cycle 1(1): loaded http://localhost:57074/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57074/tests/dromaeo/cssquery-mootools.html) 05:58:02 INFO - PROCESS | 4794 | RSS: Main: 153821184 05:58:02 INFO - PROCESS | 4794 | 06:01:03 INFO - PROCESS | 4794 | Cycle 1(1): loaded http://localhost:57074/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57074/tests/dromaeo/cssquery-prototype.html) 06:01:04 INFO - PROCESS | 4794 | RSS: Main: 153067520 06:01:04 INFO - PROCESS | 4794 | 06:04:06 INFO - PROCESS | 4794 | Cycle 1(1): loaded http://localhost:57074/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57074/tests/dromaeo/cssquery-yui.html) 06:04:07 INFO - PROCESS | 4794 | RSS: Main: 154193920 06:04:07 INFO - PROCESS | 4794 | 06:07:09 INFO - PROCESS | 4794 | Cycle 1(1): loaded http://localhost:57074/tests/dromaeo/cssquery-yui.html (next: http://localhost:57074/tests/dromaeo/cssquery-dojo.html) 06:07:10 INFO - PROCESS | 4794 | RSS: Main: 155676672 06:07:10 INFO - PROCESS | 4794 | 06:07:10 INFO - PROCESS | 4794 | __start_tp_report 06:07:10 INFO - PROCESS | 4794 | _x_x_mozilla_page_load 06:07:10 INFO - PROCESS | 4794 | _x_x_mozilla_page_load_details 06:07:10 INFO - PROCESS | 4794 | |i|pagename|runs| 06:07:10 INFO - PROCESS | 4794 | |0;dojo.html;3181.061586831884;3193.696598823111;3208.197950512372;3216.8552415141316;3231.1437469070693;5323;5403.7027963462;5436.238926550282;5466.863328416786;5482.314710661168;5382.273393091931;5384.273123128377;5425.3760817506;5461;5503.422140675221;4699.506551812062;4969.801207951687;5143.09995750744;5167.612429067816;5179.326687530615;4887.095887260868;5102.515261050195;5107.565856902168;5128.974355128238;5177.094008548508;4923.064617722639;4924.630652701044;4927.852164435073;4974.502549745032;5073.137566613685;4968.552830245295;4981.227909674007;4987.202047672355;5006.774695138727;5030.220315851012;4949.7030178189425;4992.375953005874;5003.099442100421;5003.674761140514;5046.823361182378;5147;5208.192730126799;5212.6611770235195;5227.738613069331;5333.866653333659;5940.881182376328;5982.880342393171;5991.281046274431;6009.849753756147;6012.218411606463;5864.76540938362;6027.276726792769;6030.4572588467245;6035.185249991283;6052.092186172065;5567.777288908439;5568.136938774496;5616.719164041781;5646.124850648156;5699.145128230715;6108.5418593605655;6116;6119.755209791648;6128.724207410677;6129.1419201311855;5779.711014449261;5896.086106653475;5941.70291485424;5946.048632218824;5949.434803693643;5886.470217680429;5914.290285165807;5971.701414929323;5972.552058595623;6030.758769649253;5899.262592175978;5899.7020655455735;5903.911441328383;5913.58604897653;6015.819525414245;5799.594028418054;5904.4685978261305;5907.172995780594;5912;5936.257967754031;4515.841945531891;4525.977370113194;4534.115847409789;4559.658025648089;4579;4008.398740188995;4014.397840323916;4044.5550989391145;4048.1296521248073;4051.513818341759;5419.34967803866;5474.5894057945015;5514.503694667419;5563.193336966117;5580.2466666999435;5942.405759424109;5947.732352044169;5966.582339236212;5987.970060149759;6019.307779605314;5542.39033706292;5558.666480011212;5573.247611572467;5620.044592419216;5650.576206784508;5051.494850514992;5136.075506408883;5141.331626888481;5185.248139019896;5283.392409872837;6007.939920600738;6014.398560144038;6036.185115009417;6057.60625559346;6106.023036314168;5960.493358064439;5966.850828729316;5968.373320801254;5968.791092311748;5983.102534619842;5892.793752218652;5938.703064846827;6000.429959153874;6018.789342373171;6071.119687645179;5851.9261176869695;5875;5902.557308201816;5902.970485147547;5908.763649453974;5960.195373624505;5973.104034394875;6005.339412664691;6011.068284415923;6030.6080104793045;5653.321601407857;5698.601097923106;5738.655680659007;5752.194692742935;5816.1857339973285;5845.620034697731;5921.17103605487;5927.496162826208;5930.733117009659;5942.405759424196;5463.48096930791;5757.683327416865;5762.94237057624;5767.423257674199;5769.884602308014;5752.07966725322;5797.30432348104;5859.736311865891;5884.823455296348;5947.762089516544;5719.57103217252;5757.9424205757405;5799.246098007232;5804.912926306193;5809.651420914759 06:07:10 INFO - PROCESS | 4794 | |1;ext.html;592.0645380299127;593.0007936626785;593.6022864680664;596.9671668058257;643.3020173112174;37216.62783372166;38279.234415311745;38381.424278635845;38412.80793596035;38451.80774096129;38849;39279.803600981955;39311.60688393122;39464.210715785666;39652;8381.706640267592;8483.363747718915;8493.532855692934;8534.402591818574;8537.74386768398;8358.582070896431;8477.237048665618;8489.490630562155;8497.490150590984;8510.404271700983;8490.235878770909;8532.146785321449;8549.102344253857;8576.957115214414;8586.613602387908;8448.028476725163;8492.15078492152;8498.362622803284;8519.275861551776;8519.53142577158;8392.4544904581;8499.660013599449;8527.31781457488;8529.53087580183;8559.957200214021;35892.64107358919;35960.46059309113;36146.45780313297;36384;36414.27171456556;3235.466148085563;3266.591676040495;3526.647335266453;3914.8629797956933;4131.5042194936495;28302;28592.285192870346;28981.85509072441;29311;30053.549196762066;3270.509423586457;3284.0640417480904;3318;3349.141813513014;3420.3843308204514;259575;260689.69655151793;263080;263436;263685;40832.79583602122;41612.37581436281;54310.45689543133;54507.72746136244;54547;39366.40950385747;39392.409113863316;39465.82937938384;39583.40624890629;39865.40201896974;12513;12613.30626815534;12621.495140194473;12624.305663188612;12634.936825315815;9918.40489570628;9940;9942.950285248528;9943.751406214902;9969.551370188214;13936.58190254294;13941.721165576835;14056.297185140702;14063.437462501386;14150.433982640785;5688.402717714663;5696.971515142398;5739.16782066598;5843.152742852262;5844.707764611752;924.856647219682;1023.0434543701663;1025.7025462615907;1043.6660268713938;1080.5407701726892;27935.720642793312;28143.577846332322;28230.85884570564;28332.858335708603;28392.574111388345;1036.6112707734599;1084.7884662490897;1108.9741988660458;1133.7165708572857;1170.052257671289;14608.707825843423;14791.186484743443;16561.42035028768;16613.58466038359;16766.58083547921;369808;377104;377671;378087;378095;52737.94524109496;52824.47175528196;52892.73553632284;53047.46952530502;53135.46864531305;1334.379513526215;1353.9593812185453;1355.525566051874;1358.130796290375;1359.64649191211;28361.574576380957;28888.566671499524;29221.269468263465;29305;29538;42282.36576451294;42729.78635106805;42779.14441711086;42881.57118428776;42907.14185716206;307281;309359;309495;309640;310207;31098.53352199764;43240;43767;44597.55402446064;44795.77602111969;41004.58995410127;41712.95717607084;42147.15705685808;42324;42469;35349.46975795417;35359.292814144086;35583.82208088943;36054.8197259012;36860.447093294155;34738.65261347354;35784;35803.28393432064;35946.64053359433;35955.82022089873;34674.82662586772;35378.46932296069;35432.291354173285;35446.64553354433;35453.82273088618;30596.541051884684;31736.841315794198;31974.52038219475;32318.515222272155;32549.186270342485;24608.138715144883;24614.753852461246;25067.87466062658;25333.87333063323;25382.746172538038 06:07:10 INFO - PROCESS | 4794 | |2;jquery.html;354.80840346213046;357.6244942810052;360.55291438616126;360.72584835525004;361.49571347969584;16300.673986520278;17223.569410764736;17454.389096381597;18177.4546763597;18258.634827303464;10184.898151018506;10229.386236825796;10235.641752538662;10562.366258024524;10621.309614875046;4723.2442809150625;4840.249761286988;4853.174960256747;4866.367372241603;4959.57843583294;5249.711265880375;5279.656822306557;5280.894382112356;5293.232481290211;5301.496357846017;5010.073136469765;5175.663581867167;5241.947580524203;5263.631545791796;5265.052290587692;5171.379434467869;5178.637495375326;5180.9740951295;5246.2917506136755;5249.1338929076655;4961.776720047606;5091.338126043628;5105.055564720538;5116.079105760961;5116.667416617908;11621.825672614917;11748.471318790675;12199.695007624792;19840.702389464168;19891.80108198914;1996.8402527797741;2064.917403303866;2069.4102180878376;2081.4067990622752;2201.768814274494;8999.5050272235;9188.678396256166;9222.584983675752;9230.492322922237;9253.167214950687;1710.6236627941832;1773.7162054071416;1793.5426466251154;1812.5378028602754;1825.853931685462;60113.39886601165;60186.9906504673;63958;64418;65543.67228163828;9665.613375465044;9846.409215447096;9874.506274686237;9954.701358959242;9975.900240997642;12650.177738447155;12677.87322126767;12727.427265773062;12739.490420383267;12761.553345632858;6799.7960061197255;6810.046593476917;6847.589144651237;6895.138107736533;6923.5499692519825;6459.741610335534;6474.1907261592305;6480.2547707013355;6498.155239818793;6520.47836173105;4190.245755763992;4225.9788701056295;4227.661787057028;4228.534861165269;4262.147570485915;1720.380662961333;1747.493226964166;1761.409927674218;1773.9467815965543;1785.1698959983669;376.095490345719;409.1857204163752;413.2932685108498;428.0903080952975;950.7860731335394;8920.375573709778;10029.799404012025;10287.845682314772;10380.273380863418;10399.792004159874;405.2935901183659;406.778305823327;411.695345444369;419.5552714123039;424.0839786062153;5409.29679141709;5498.230247765316;5537.640053396516;5563.415841336601;5567.109262517978;571033;571464;576228;576618;583177;82388;82955.58522207351;84142;84494.57752711196;84722;441.7813182474696;443.70271917814495;443.77589317394506;445.99777001114785;447.75373544550365;9389.061093890556;9555.378900371454;9566.186874115778;9577.377470464398;9641.903580964381;31828.36343273168;32889.83555082305;33228.50157247595;33528.32943341168;33839.49240761341;48752;49633.50366496289;49889.25166122583;50099.74950125226;53207.20189197088;8709.564521773758;8889.64441422336;8996.145366190201;9157.404768690014;9157.679481218125;10545.736356591147;10559.472026398804;10590.8411373831;16718.66562668764;17042.914785425994;8650.091740367423;8910.643574256957;13699.520516781864;13781.104228225133;13959.162450253018;9109.498977556297;9417.246620270498;9475.810483790423;9641.566129524048;9684.46735429558;9164.495952722664;9496.335256531976;9800.901990980285;10223.131033862204;10231.232657550863;14494.420223190955;14516.637084072983;15010.174440405446;15101.546953591409;15421.383144674535;15327.61680957985;15472.767908481157;15655.608609784846;15787;16128.354865805706 06:07:10 INFO - PROCESS | 4794 | |3;mootools.html;1415.2569900802077;1476.453712126513;1558.2208895552224;1615.3054186699715;1706.5818874375786;7750.7674769756995;7861.410394220435;7905.841883162333;8087.959560202198;8098.149694282104;7974.96012519938;8097.311728503084;8154.836903261946;8165.795855103611;8166.877496837537;2233.6426171812554;2271.114265436481;2279.407354087941;2292.5071109711407;2293.334932869466;2241.977580224201;2259.3109101723967;2309.8498597591188;2313.0400883633274;2316.791488766011;2227.8329125315668;2231.787980141892;2234.1175235781857;2248.6402175651897;2263.6378179491285;2206.5366273082673;2237.6196046672026;2243.6410174372186;2250.7861753133425;2251.6960210371553;2232.140625859056;2232.2968264996475;2247.898844551999;2252.087904398721;2265.66015097735;7729.806754831118;7886.566238856861;7936.761897143095;7948.5628290444;7963.482373645695;4566.223741963841;4587.587117159472;4630.699004564693;4646.53534646536;4666.6966647168165;2945;2955.2020954342424;2993.311538346171;3007.7593792496546;3012.9397412051853;862.4825104936988;866.1035827918138;890.8975467821218;911.9635214591408;928.2991341537096;10911;10933.289336193202;10962.616308429167;10963.56145754169;10985.395803230818;3965.7025723070883;4045.8381664733083;4091.959080409217;4102.466679331727;4126.793660316972;8703.608337624695;8764;8784.429012114193;8821.294296456268;8899.377043606886;4589.173948689268;4615.515370886009;4626.421697287839;4648.3259927310355;4659.883502912387;4255.319148936217;4276.550962148992;4295.6778241632;4299.785010749512;4317;3383.9661603384143;3434.072800343893;3446.603640581315;3449.9482507762405;3460.3598334308235;998.1814911772423;1008.7578981044496;1010.6967909627083;1016.3089099412323;1018.1956254558963;957.3250858144991;959.8032403357295;1068.8396740488988;1085.9945700271605;1271.1483306184878;7447.218042105609;7486.737964171228;7488.138864030598;7520.736774212876;7540.359069479046;1073.613499140309;1097.4293367448881;1131.140333346646;1132.4394424759796;1142.2175809570472;5907.881842363128;5917.704114794243;5948.750762339871;5992.790252341147;6009.128676341906;8447.66209351619;8568.828623427496;8591.05498395176;8638.913610863936;8937.642494300286;9106.590203440861;9237.769055773659;9240.7689807754;9328.906710932939;9383.296252780932;7242.818929526804;7256.637168141572;7306.415486761046;7329.377002954702;7376.889346659805;6925.099737034153;6976.825579360557;6985.266547012694;6988.79033628992;7010.719571217094;7646.617669116633;7881.487703299267;7895.64469598858;7896.249856263646;7990;7939.166387529226;7982.8004299890645;7982.960085199769;8103.108658047492;8152.144024877302;6708.597484150967;6795.93204067953;6969.721211151497;6975.930240697731;6982.825429364307;7407.703691852265;7444;7461.104667439942;7477.88783168242;7517.135529414188;6896.689648965909;7063.858722825617;7101.573905565682;7110.14678238594;7207;6552.180977377828;6586.1438013059915;6816.897746533707;6822.044913711985;6914.861702765816;6651.368120028589;6894;6903.965480172567;6960.9303906962305;6968.547044442095;5731.168980497888;6015;6075.483583895419;6083.270007599116;6341.302456729848;6023.548233882389;6064.241969753781;6105.908411373922;6108.694565271808;6114.602550834182 06:07:10 INFO - PROCESS | 4794 | |4;prototype.html;309.9225193701575;311.79265788250814;313.37168976202736;315.9668234835341;317.6378928022055;6284.654344011084;6323.241211054668;6434.195725534309;6491.058796474508;6515.543911926161;6270.153529273547;6315.557910946224;6325.272593651732;6329.936700633004;6333.20834895638;4593.553030795306;4713.057388522309;4714.245720684691;4735.85792426226;4756.405449318835;4697.295405689139;4710.97644511777;4715.41057367829;4716.622670186394;4726.763661816913;4682.555157260055;4683.110209060268;4684.812607495696;4687.695299805502;4688.484266730674;4693.953060469403;4701.153792317382;4708.74101924394;4712.481627021025;4714.7642617869315;3940.704447166474;4041.1109555897656;4049.6152865477734;4055.4119652650497;4057.3102572562734;5867.266591676041;5916.26046744157;5954.732037058343;5961.195238642771;5982.0727787193055;5400.837974860721;5455.5908306877145;5460.099083651193;5467.507924286833;5477.780888764445;6605.9339406605795;6629.767958121491;6640.93359066408;6643.501737369668;6653.4344580710695;4335.913281734379;4455.688101832873;4457.108578284324;4464.955350446487;4473.575010374042;6829.692663830139;6883.449324054114;6896.344847239504;6904.171499420051;6915.997180408863;4543.250363689954;4555.931661025087;4560.88597785058;4567.36056952027;4577.862664120082;4425.203463376559;4628.39830821991;4636.420447444069;4638.79125439356;4644.396228490275;5393.7303134843105;5399.676019438846;5400.594955378362;5400.945990540123;5402.864928376822;6618.073469714244;6676;6682.398584127452;6683.732650694015;6683.832904177434;1627.397862790775;1627.5524230836377;1627.5849658337286;1633.1752465005097;1634.1502418742425;1064.1539975719322;1072.5656109275756;1075.408525311076;1089.8310761831929;1097.5006372100675;6218.067289906459;6328.588641738273;6369.490440764727;6374.936250637527;6383.457406120532;6876.484263680244;6957.61733104674;7000.2999700030605;7003.474739394565;7007.019017337577;6373.52198585108;6413;6432;6433.906235939901;6436.613803171825;3661.41417373219;3767.1900541383184;3787.8295476703615;3795.5065841440437;3796.563395209531;7010.263922288188;7027.297270273034;7060.7881763547175;7107.111611048619;7124.145102587722;7153.856922861513;7164.319389657974;7180.497365184491;7192.856142877114;7195.640217989079;6914.377706006484;7053.823654408681;7086.858262834715;7130.288730704698;7165.462590305644;6989.405900498515;6990.790276291719;7002.334778196063;7015.508914376149;7032.648367581703;6902.413294869792;6925.826854328682;6936.583804971718;6938.5143039986715;6944.826379340557;6852.314768523108;7120.0387947626405;7121.4302855770375;7123;7123.715051397886;4564.634829213722;4592.793324300348;4592.862214133581;4599.241125214302;4603.884902877455;6966.79099627012;6998.2651821558;6999.0551275577145;7014.158301003912;7023.859522809617;6590.077389165424;6733.124693789776;6793.388595026471;6828.385445309946;6833;6751.189857217166;6766.05275261454;6768.120144381396;6786.558873673195;6797.810383183022;6449.032645103272;6547.345265473415;6583.539152259296;6590.2421221560135;6607.702653380706;6634.170728658918;6756.459483241427;6829.146356705412;6830.112085428863;6857.485688573477;6527.2167339919515;6534.019897015486;6543.051257567721;6547.836304092436;6672.666366681744 06:07:10 INFO - PROCESS | 4794 | |5;yui.html;705.326413275322;709.8580283943213;716.802879208218;778.136268741697;801.20680526279;13056.412461439235;13443.932780336085;13538.39077241524;13542.661433464156;13606.115602485832;12426.937865310683;12969.286689232089;13146.539871104513;13169.144005639626;13241;816.2245866426889;822.576373167819;824.0194168938973;825.9091499935003;826.446280991737;812.3988248695981;816.7304789419507;823.4400607586839;825.0511911301991;827.548985802736;857.391252210931;860.8278344331128;861.9525926074064;863.8574635185187;868.5483548554748;840.756180707591;847.9406441549094;850.3962186847345;854.3549620036863;857.691231156783;626.4894111299277;627.8179327994876;630;635.3138610300864;636.226984214182;12652.17760845542;12697.428615712315;12726.300053497054;12730.23618582888;12834.679133021657;10555.788884222273;10605.734856628646;10840;10960.616378426717;11135.610253641165;8481;8542;8609.526476043815;8671.523066231355;8969.416987895765;3264.722498587623;3349.2631621043333;3369.528266042756;3422.3839708852397;3438.5014172944784;41127.588724112975;43325;44057.55942440566;48877.511224887654;49768.50231497675;8539.615717292736;8792.648294068293;8936.195742383086;8952.641894324153;9396.577154028086;17815;17860.19629116693;17863.46409607714;17975.640487190183;17986.460406187834;7372.852542949218;7468.3278504934815;7486.438517111238;7565.735199268;7623.275788800055;3504.369213541587;3688.5204923359793;3773.4339849022317;3778.1499162688174;3812.4853144825647;2756.9172924812287;2850.087971848988;2857.8142420742583;2865.5271880139962;2874.2670618992443;495.5960891873112;497.76604995651985;500.2346409992717;506.172408112731;520.3911423634357;579.5161040531119;592.9525637948954;596.31126049413;610.6671863834221;634.7016902056026;7335.816604584928;7573.129090154703;7676.309132178131;7703.34521565662;7723.150453450116;609.1928195141455;615.1480199923138;635.6916895305866;642.9421352078335;647.3138473218404;3529.1882866940746;3632.2917031179195;3644.453332000221;3653.634636536325;3661.23114146027;57579.42420575741;57658.98193563289;57670.423295767345;58487.70756146192;58822.41177588255;47888;48845.75577122163;49533;50054.74972625187;50135;45946.54053459423;47889;48284.75857620689;48725.51274487281;49630;7790;7900.367970562456;7939.483933544301;7993.600319984093;8103.594820259082;33891.66108338885;34319.656803431644;34675.4798678015;34861;34970.65029349674;39459.80270098746;42694.78652606717;42989.78505107579;43407.34888976605;43515.129697406504;9750.414975101517;10064;10204.795904081728;10362.326448780805;10441.634542790965;10761.408122553335;11017.1186305097;11036.061934735317;11153.832692509457;11242.66272011841;10136.695899123039;10353.534090965773;10436.37381757097;10444.321119127233;10987;10066.295359324777;10112.89887101149;10385.740356491147;10772.084372828398;10795;10197.971706998096;10353.844692329772;10480.318779279323;10495.580176792842;10540.841887371542;9165.495897725688;9278.907210928075;9304.302177336862;9540.761480963032;9549.761255968378;8015.318697910743;8041.959790201012;8269.793255168668;8721.080586444887;9108.681196158368 06:07:10 INFO - PROCESS | 4794 | __end_tp_report 06:07:10 INFO - PROCESS | 4794 | __start_cc_report 06:07:10 INFO - PROCESS | 4794 | _x_x_mozilla_cycle_collect,301 06:07:10 INFO - PROCESS | 4794 | __end_cc_report 06:07:10 INFO - PROCESS | 4794 | __startTimestamp1450706830004__endTimestamp 06:07:10 INFO - PROCESS | 4794 | 06:07:10 INFO - PROCESS | 4794 | ------- Summary: start ------- 06:07:10 INFO - PROCESS | 4794 | Number of tests: 6 06:07:10 INFO - PROCESS | 4794 | 06:07:10 INFO - PROCESS | 4794 | [#0] dojo.html Cycles:165 Average:5497.85 Median:5757.68 stddev:636.21 (11.0%) stddev-sans-first:611.65 06:07:10 INFO - PROCESS | 4794 | Values: 3181.1 3193.7 3208.2 3216.9 3231.1 5323.0 5403.7 5436.2 5466.9 5482.3 5382.3 5384.3 5425.4 5461.0 5503.4 4699.5 4969.8 5143.1 5167.6 5179.3 4887.1 5102.5 5107.6 5129.0 5177.1 4923.1 4924.6 4927.9 4974.5 5073.1 4968.6 4981.2 4987.2 5006.8 5030.2 4949.7 4992.4 5003.1 5003.7 5046.8 5147.0 5208.2 5212.7 5227.7 5333.9 5940.9 5982.9 5991.3 6009.8 6012.2 5864.8 6027.3 6030.5 6035.2 6052.1 5567.8 5568.1 5616.7 5646.1 5699.1 6108.5 6116.0 6119.8 6128.7 6129.1 5779.7 5896.1 5941.7 5946.0 5949.4 5886.5 5914.3 5971.7 5972.6 6030.8 5899.3 5899.7 5903.9 5913.6 6015.8 5799.6 5904.5 5907.2 5912.0 5936.3 4515.8 4526.0 4534.1 4559.7 4579.0 4008.4 4014.4 4044.6 4048.1 4051.5 5419.3 5474.6 5514.5 5563.2 5580.2 5942.4 5947.7 5966.6 5988.0 6019.3 5542.4 5558.7 5573.2 5620.0 5650.6 5051.5 5136.1 5141.3 5185.2 5283.4 6007.9 6014.4 6036.2 6057.6 6106.0 5960.5 5966.9 5968.4 5968.8 5983.1 5892.8 5938.7 6000.4 6018.8 6071.1 5851.9 5875.0 5902.6 5903.0 5908.8 5960.2 5973.1 6005.3 6011.1 6030.6 5653.3 5698.6 5738.7 5752.2 5816.2 5845.6 5921.2 5927.5 5930.7 5942.4 5463.5 5757.7 5762.9 5767.4 5769.9 5752.1 5797.3 5859.7 5884.8 5947.8 5719.6 5757.9 5799.2 5804.9 5809.7 06:07:10 INFO - PROCESS | 4794 | 06:07:10 INFO - PROCESS | 4794 | [#1] ext.html Cycles:180 Average:46957.79 Median:36399.14 stddev:83889.10 (230.5%) stddev-sans-first:84052.20 06:07:10 INFO - PROCESS | 4794 | Values: 592.1 593.0 593.6 597.0 643.3 37216.6 38279.2 38381.4 38412.8 38451.8 38849.0 39279.8 39311.6 39464.2 39652.0 8381.7 8483.4 8493.5 8534.4 8537.7 8358.6 8477.2 8489.5 8497.5 8510.4 8490.2 8532.1 8549.1 8577.0 8586.6 8448.0 8492.2 8498.4 8519.3 8519.5 8392.5 8499.7 8527.3 8529.5 8560.0 35892.6 35960.5 36146.5 36384.0 36414.3 3235.5 3266.6 3526.6 3914.9 4131.5 28302.0 28592.3 28981.9 29311.0 30053.5 3270.5 3284.1 3318.0 3349.1 3420.4 259575.0 260689.7 263080.0 263436.0 263685.0 40832.8 41612.4 54310.5 54507.7 54547.0 39366.4 39392.4 39465.8 39583.4 39865.4 12513.0 12613.3 12621.5 12624.3 12634.9 9918.4 9940.0 9943.0 9943.8 9969.6 13936.6 13941.7 14056.3 14063.4 14150.4 5688.4 5697.0 5739.2 5843.2 5844.7 924.9 1023.0 1025.7 1043.7 1080.5 27935.7 28143.6 28230.9 28332.9 28392.6 1036.6 1084.8 1109.0 1133.7 1170.1 14608.7 14791.2 16561.4 16613.6 16766.6 369808.0 377104.0 377671.0 378087.0 378095.0 52737.9 52824.5 52892.7 53047.5 53135.5 1334.4 1354.0 1355.5 1358.1 1359.6 28361.6 28888.6 29221.3 29305.0 29538.0 42282.4 42729.8 42779.1 42881.6 42907.1 307281.0 309359.0 309495.0 309640.0 310207.0 31098.5 43240.0 43767.0 44597.6 44795.8 41004.6 41713.0 42147.2 42324.0 42469.0 35349.5 35359.3 35583.8 36054.8 36860.4 34738.7 35784.0 35803.3 35946.6 35955.8 34674.8 35378.5 35432.3 35446.6 35453.8 30596.5 31736.8 31974.5 32318.5 32549.2 24608.1 24614.8 25067.9 25333.9 25382.7 06:07:10 INFO - PROCESS | 4794 | 06:07:10 INFO - PROCESS | 4794 | [#2] jquery.html Cycles:180 Average:28878.65 Median:4859.77 stddev:94330.64 (1941.1%) stddev-sans-first:94570.94 06:07:10 INFO - PROCESS | 4794 | Values: 354.8 357.6 360.6 360.7 361.5 16300.7 17223.6 17454.4 18177.5 18258.6 10184.9 10229.4 10235.6 10562.4 10621.3 4723.2 4840.2 4853.2 4866.4 4959.6 5249.7 5279.7 5280.9 5293.2 5301.5 5010.1 5175.7 5241.9 5263.6 5265.1 5171.4 5178.6 5181.0 5246.3 5249.1 4961.8 5091.3 5105.1 5116.1 5116.7 11621.8 11748.5 12199.7 19840.7 19891.8 1996.8 2064.9 2069.4 2081.4 2201.8 8999.5 9188.7 9222.6 9230.5 9253.2 1710.6 1773.7 1793.5 1812.5 1825.9 60113.4 60187.0 63958.0 64418.0 65543.7 9665.6 9846.4 9874.5 9954.7 9975.9 12650.2 12677.9 12727.4 12739.5 12761.6 6799.8 6810.0 6847.6 6895.1 6923.5 6459.7 6474.2 6480.3 6498.2 6520.5 4190.2 4226.0 4227.7 4228.5 4262.1 1720.4 1747.5 1761.4 1773.9 1785.2 376.1 409.2 413.3 428.1 950.8 8920.4 10029.8 10287.8 10380.3 10399.8 405.3 406.8 411.7 419.6 424.1 5409.3 5498.2 5537.6 5563.4 5567.1 571033.0 571464.0 576228.0 576618.0 583177.0 82388.0 82955.6 84142.0 84494.6 84722.0 441.8 443.7 443.8 446.0 447.8 9389.1 9555.4 9566.2 9577.4 9641.9 31828.4 32889.8 33228.5 33528.3 33839.5 48752.0 49633.5 49889.3 50099.7 53207.2 8709.6 8889.6 8996.1 9157.4 9157.7 10545.7 10559.5 10590.8 16718.7 17042.9 8650.1 8910.6 13699.5 13781.1 13959.2 9109.5 9417.2 9475.8 9641.6 9684.5 9164.5 9496.3 9800.9 10223.1 10231.2 14494.4 14516.6 15010.2 15101.5 15421.4 15327.6 15472.8 15655.6 15787.0 16128.4 06:07:10 INFO - PROCESS | 4794 | 06:07:10 INFO - PROCESS | 4794 | [#3] mootools.html Cycles:180 Average:5370.37 Median:6227.95 stddev:2799.94 (45.0%) stddev-sans-first:2792.01 06:07:10 INFO - PROCESS | 4794 | Values: 1415.3 1476.5 1558.2 1615.3 1706.6 7750.8 7861.4 7905.8 8088.0 8098.1 7975.0 8097.3 8154.8 8165.8 8166.9 2233.6 2271.1 2279.4 2292.5 2293.3 2242.0 2259.3 2309.8 2313.0 2316.8 2227.8 2231.8 2234.1 2248.6 2263.6 2206.5 2237.6 2243.6 2250.8 2251.7 2232.1 2232.3 2247.9 2252.1 2265.7 7729.8 7886.6 7936.8 7948.6 7963.5 4566.2 4587.6 4630.7 4646.5 4666.7 2945.0 2955.2 2993.3 3007.8 3012.9 862.5 866.1 890.9 912.0 928.3 10911.0 10933.3 10962.6 10963.6 10985.4 3965.7 4045.8 4092.0 4102.5 4126.8 8703.6 8764.0 8784.4 8821.3 8899.4 4589.2 4615.5 4626.4 4648.3 4659.9 4255.3 4276.6 4295.7 4299.8 4317.0 3384.0 3434.1 3446.6 3449.9 3460.4 998.2 1008.8 1010.7 1016.3 1018.2 957.3 959.8 1068.8 1086.0 1271.1 7447.2 7486.7 7488.1 7520.7 7540.4 1073.6 1097.4 1131.1 1132.4 1142.2 5907.9 5917.7 5948.8 5992.8 6009.1 8447.7 8568.8 8591.1 8638.9 8937.6 9106.6 9237.8 9240.8 9328.9 9383.3 7242.8 7256.6 7306.4 7329.4 7376.9 6925.1 6976.8 6985.3 6988.8 7010.7 7646.6 7881.5 7895.6 7896.2 7990.0 7939.2 7982.8 7983.0 8103.1 8152.1 6708.6 6795.9 6969.7 6975.9 6982.8 7407.7 7444.0 7461.1 7477.9 7517.1 6896.7 7063.9 7101.6 7110.1 7207.0 6552.2 6586.1 6816.9 6822.0 6914.9 6651.4 6894.0 6904.0 6960.9 6968.5 5731.2 6015.0 6075.5 6083.3 6341.3 6023.5 6064.2 6105.9 6108.7 6114.6 06:07:10 INFO - PROCESS | 4794 | 06:07:10 INFO - PROCESS | 4794 | [#4] prototype.html Cycles:180 Average:5554.97 Median:6374.23 stddev:1725.47 (27.1%) stddev-sans-first:1684.81 06:07:10 INFO - PROCESS | 4794 | Values: 309.9 311.8 313.4 316.0 317.6 6284.7 6323.2 6434.2 6491.1 6515.5 6270.2 6315.6 6325.3 6329.9 6333.2 4593.6 4713.1 4714.2 4735.9 4756.4 4697.3 4711.0 4715.4 4716.6 4726.8 4682.6 4683.1 4684.8 4687.7 4688.5 4694.0 4701.2 4708.7 4712.5 4714.8 3940.7 4041.1 4049.6 4055.4 4057.3 5867.3 5916.3 5954.7 5961.2 5982.1 5400.8 5455.6 5460.1 5467.5 5477.8 6605.9 6629.8 6640.9 6643.5 6653.4 4335.9 4455.7 4457.1 4465.0 4473.6 6829.7 6883.4 6896.3 6904.2 6916.0 4543.3 4555.9 4560.9 4567.4 4577.9 4425.2 4628.4 4636.4 4638.8 4644.4 5393.7 5399.7 5400.6 5400.9 5402.9 6618.1 6676.0 6682.4 6683.7 6683.8 1627.4 1627.6 1627.6 1633.2 1634.2 1064.2 1072.6 1075.4 1089.8 1097.5 6218.1 6328.6 6369.5 6374.9 6383.5 6876.5 6957.6 7000.3 7003.5 7007.0 6373.5 6413.0 6432.0 6433.9 6436.6 3661.4 3767.2 3787.8 3795.5 3796.6 7010.3 7027.3 7060.8 7107.1 7124.1 7153.9 7164.3 7180.5 7192.9 7195.6 6914.4 7053.8 7086.9 7130.3 7165.5 6989.4 6990.8 7002.3 7015.5 7032.6 6902.4 6925.8 6936.6 6938.5 6944.8 6852.3 7120.0 7121.4 7123.0 7123.7 4564.6 4592.8 4592.9 4599.2 4603.9 6966.8 6998.3 6999.1 7014.2 7023.9 6590.1 6733.1 6793.4 6828.4 6833.0 6751.2 6766.1 6768.1 6786.6 6797.8 6449.0 6547.3 6583.5 6590.2 6607.7 6634.2 6756.5 6829.1 6830.1 6857.5 6527.2 6534.0 6543.1 6547.8 6672.7 06:07:10 INFO - PROCESS | 4794 | 06:07:10 INFO - PROCESS | 4794 | [#5] yui.html Cycles:180 Average:13240.39 Median:49581.50 stddev:15781.61 (31.8%) stddev-sans-first:15797.81 06:07:10 INFO - PROCESS | 4794 | Values: 705.3 709.9 716.8 778.1 801.2 13056.4 13443.9 13538.4 13542.7 13606.1 12426.9 12969.3 13146.5 13169.1 13241.0 816.2 822.6 824.0 825.9 826.4 812.4 816.7 823.4 825.1 827.5 857.4 860.8 862.0 863.9 868.5 840.8 847.9 850.4 854.4 857.7 626.5 627.8 630.0 635.3 636.2 12652.2 12697.4 12726.3 12730.2 12834.7 10555.8 10605.7 10840.0 10960.6 11135.6 8481.0 8542.0 8609.5 8671.5 8969.4 3264.7 3349.3 3369.5 3422.4 3438.5 41127.6 43325.0 44057.6 48877.5 49768.5 8539.6 8792.6 8936.2 8952.6 9396.6 17815.0 17860.2 17863.5 17975.6 17986.5 7372.9 7468.3 7486.4 7565.7 7623.3 3504.4 3688.5 3773.4 3778.1 3812.5 2756.9 2850.1 2857.8 2865.5 2874.3 495.6 497.8 500.2 506.2 520.4 579.5 593.0 596.3 610.7 634.7 7335.8 7573.1 7676.3 7703.3 7723.2 609.2 615.1 635.7 642.9 647.3 3529.2 3632.3 3644.5 3653.6 3661.2 57579.4 57659.0 57670.4 58487.7 58822.4 47888.0 48845.8 49533.0 50054.7 50135.0 45946.5 47889.0 48284.8 48725.5 49630.0 7790.0 7900.4 7939.5 7993.6 8103.6 33891.7 34319.7 34675.5 34861.0 34970.7 39459.8 42694.8 42989.8 43407.3 43515.1 9750.4 10064.0 10204.8 10362.3 10441.6 10761.4 11017.1 11036.1 11153.8 11242.7 10136.7 10353.5 10436.4 10444.3 10987.0 10066.3 10112.9 10385.7 10772.1 10795.0 10198.0 10353.8 10480.3 10495.6 10540.8 9165.5 9278.9 9304.3 9540.8 9549.8 8015.3 8042.0 8269.8 8721.1 9108.7 06:07:10 INFO - PROCESS | 4794 | -------- Summary: end -------- 06:07:10 INFO - PROCESS | 4794 | 06:07:10 INFO - TEST-INFO | 4794: exit 0 06:07:10 INFO - TEST-OK | dromaeo_css | took 1110028ms 06:07:10 INFO - TEST-START | kraken 06:07:10 INFO - operating with platform_type : linux_ 06:07:10 INFO - Initialising browser for kraken test... 06:07:10 INFO - TEST-INFO | started process 5030 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpqLlPt4/profile http://localhost:57074/getInfo.html) 06:07:14 INFO - PROCESS | 5030 | JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 06:07:15 INFO - PROCESS | 5030 | __metrics Screen width/height:1600/1200 06:07:15 INFO - PROCESS | 5030 | colorDepth:24 06:07:15 INFO - PROCESS | 5030 | Browser inner width/height: 1024/670 06:07:15 INFO - PROCESS | 5030 | __metrics 06:07:15 INFO - PROCESS | 5030 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 06:07:15 INFO - TEST-INFO | 5030: exit 0 06:07:15 INFO - Browser initialized. 06:07:15 INFO - Running cycle 1/1 for kraken test... 06:07:15 INFO - TEST-INFO | started process 5154 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpqLlPt4/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:07:27 INFO - PROCESS | 5154 | RSS: Main: 150765568 06:07:27 INFO - PROCESS | 5154 | 06:07:30 INFO - PROCESS | 5154 | Cycle 1(1): loaded http://localhost:57074/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57074/tests/kraken/driver.html?testName=audio-beat-detection) 06:07:30 INFO - PROCESS | 5154 | RSS: Main: 151392256 06:07:30 INFO - PROCESS | 5154 | 06:07:33 INFO - PROCESS | 5154 | Cycle 1(1): loaded http://localhost:57074/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57074/tests/kraken/driver.html?testName=audio-dft) 06:07:34 INFO - PROCESS | 5154 | RSS: Main: 151851008 06:07:34 INFO - PROCESS | 5154 | 06:07:36 INFO - PROCESS | 5154 | Cycle 1(1): loaded http://localhost:57074/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57074/tests/kraken/driver.html?testName=audio-fft) 06:07:37 INFO - PROCESS | 5154 | RSS: Main: 146243584 06:07:37 INFO - PROCESS | 5154 | 06:07:39 INFO - PROCESS | 5154 | Cycle 1(1): loaded http://localhost:57074/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57074/tests/kraken/driver.html?testName=audio-oscillator) 06:07:40 INFO - PROCESS | 5154 | RSS: Main: 145977344 06:07:40 INFO - PROCESS | 5154 | 06:07:42 INFO - PROCESS | 5154 | Cycle 1(1): loaded http://localhost:57074/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57074/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:07:42 INFO - PROCESS | 5154 | RSS: Main: 146964480 06:07:42 INFO - PROCESS | 5154 | 06:07:45 INFO - PROCESS | 5154 | Cycle 1(1): loaded http://localhost:57074/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57074/tests/kraken/driver.html?testName=imaging-darkroom) 06:07:46 INFO - PROCESS | 5154 | RSS: Main: 147759104 06:07:46 INFO - PROCESS | 5154 | 06:07:49 INFO - PROCESS | 5154 | Cycle 1(1): loaded http://localhost:57074/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57074/tests/kraken/driver.html?testName=imaging-desaturate) 06:07:50 INFO - PROCESS | 5154 | RSS: Main: 148828160 06:07:50 INFO - PROCESS | 5154 | 06:07:53 INFO - PROCESS | 5154 | Cycle 1(1): loaded http://localhost:57074/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57074/tests/kraken/driver.html?testName=json-parse-financial) 06:07:53 INFO - PROCESS | 5154 | RSS: Main: 149348352 06:07:53 INFO - PROCESS | 5154 | 06:07:55 INFO - PROCESS | 5154 | Cycle 1(1): loaded http://localhost:57074/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57074/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:07:55 INFO - PROCESS | 5154 | RSS: Main: 149135360 06:07:55 INFO - PROCESS | 5154 | 06:07:57 INFO - PROCESS | 5154 | Cycle 1(1): loaded http://localhost:57074/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57074/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:07:58 INFO - PROCESS | 5154 | RSS: Main: 148480000 06:07:58 INFO - PROCESS | 5154 | 06:08:00 INFO - PROCESS | 5154 | Cycle 1(1): loaded http://localhost:57074/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57074/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:08:00 INFO - PROCESS | 5154 | RSS: Main: 149045248 06:08:00 INFO - PROCESS | 5154 | 06:08:03 INFO - PROCESS | 5154 | Cycle 1(1): loaded http://localhost:57074/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57074/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:08:04 INFO - PROCESS | 5154 | RSS: Main: 149737472 06:08:04 INFO - PROCESS | 5154 | 06:08:06 INFO - PROCESS | 5154 | Cycle 1(1): loaded http://localhost:57074/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57074/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:08:07 INFO - PROCESS | 5154 | RSS: Main: 149934080 06:08:07 INFO - PROCESS | 5154 | 06:08:08 INFO - PROCESS | 5154 | Cycle 1(1): loaded http://localhost:57074/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57074/tests/kraken/driver.html?testName=ai-astar) 06:08:09 INFO - PROCESS | 5154 | RSS: Main: 148799488 06:08:09 INFO - PROCESS | 5154 | 06:08:09 INFO - PROCESS | 5154 | __start_tp_report 06:08:09 INFO - PROCESS | 5154 | _x_x_mozilla_page_load 06:08:09 INFO - PROCESS | 5154 | _x_x_mozilla_page_load_details 06:08:09 INFO - PROCESS | 5154 | |i|pagename|runs| 06:08:09 INFO - PROCESS | 5154 | |0;ai-astar;112;107;112;110;111;125;111;111;112;112 06:08:09 INFO - PROCESS | 5154 | |1;audio-beat-detection;157;126;153;164;125;155;149;127;164;125 06:08:09 INFO - PROCESS | 5154 | |2;audio-dft;164;163;162;163;162;161;161;162;174;163 06:08:09 INFO - PROCESS | 5154 | |3;audio-fft;71;74;71;73;72;72;133;72;73;71 06:08:09 INFO - PROCESS | 5154 | |4;audio-oscillator;94;93;139;92;92;94;136;93;93;136 06:08:09 INFO - PROCESS | 5154 | |5;imaging-gaussian-blur;110;111;110;110;110;110;110;111;110;111 06:08:09 INFO - PROCESS | 5154 | |6;imaging-darkroom;151;146;147;147;146;148;147;146;146;146 06:08:09 INFO - PROCESS | 5154 | |7;imaging-desaturate;96;95;96;96;97;96;97;97;97;98 06:08:09 INFO - PROCESS | 5154 | |8;json-parse-financial;61;62;63;62;64;59;60;60;56;63 06:08:09 INFO - PROCESS | 5154 | |9;json-stringify-tinderbox;67;71;68;67;69;67;69;67;67;68 06:08:09 INFO - PROCESS | 5154 | |10;stanford-crypto-aes;83;91;86;87;86;84;84;84;85;84 06:08:09 INFO - PROCESS | 5154 | |11;stanford-crypto-ccm;128;122;125;124;124;121;127;125;118;127 06:08:09 INFO - PROCESS | 5154 | |12;stanford-crypto-pbkdf2;144;163;168;147;159;144;155;161;155;146 06:08:09 INFO - PROCESS | 5154 | |13;stanford-crypto-sha256-iterative;67;70;71;69;69;67;70;70;67;67 06:08:09 INFO - PROCESS | 5154 | __end_tp_report 06:08:09 INFO - PROCESS | 5154 | __start_cc_report 06:08:09 INFO - PROCESS | 5154 | _x_x_mozilla_cycle_collect,731 06:08:09 INFO - PROCESS | 5154 | __end_cc_report 06:08:09 INFO - PROCESS | 5154 | __startTimestamp1450706889249__endTimestamp 06:08:09 INFO - PROCESS | 5154 | 06:08:09 INFO - PROCESS | 5154 | ------- Summary: start ------- 06:08:09 INFO - PROCESS | 5154 | Number of tests: 14 06:08:09 INFO - PROCESS | 5154 | 06:08:09 INFO - PROCESS | 5154 | [#0] ai-astar Cycles:10 Average:112.30 Median:112.00 stddev:4.72 (4.2%) stddev-sans-first:5.00 06:08:09 INFO - PROCESS | 5154 | Values: 112.0 107.0 112.0 110.0 111.0 125.0 111.0 111.0 112.0 112.0 06:08:09 INFO - PROCESS | 5154 | 06:08:09 INFO - PROCESS | 5154 | [#1] audio-beat-detection Cycles:10 Average:144.50 Median:154.00 stddev:16.76 (10.9%) stddev-sans-first:17.16 06:08:09 INFO - PROCESS | 5154 | Values: 157.0 126.0 153.0 164.0 125.0 155.0 149.0 127.0 164.0 125.0 06:08:09 INFO - PROCESS | 5154 | 06:08:09 INFO - PROCESS | 5154 | [#2] audio-dft Cycles:10 Average:163.50 Median:163.00 stddev:3.81 (2.3%) stddev-sans-first:4.03 06:08:09 INFO - PROCESS | 5154 | Values: 164.0 163.0 162.0 163.0 162.0 161.0 161.0 162.0 174.0 163.0 06:08:09 INFO - PROCESS | 5154 | 06:08:09 INFO - PROCESS | 5154 | [#3] audio-fft Cycles:10 Average:78.20 Median:72.00 stddev:19.28 (26.8%) stddev-sans-first:20.27 06:08:09 INFO - PROCESS | 5154 | Values: 71.0 74.0 71.0 73.0 72.0 72.0 133.0 72.0 73.0 71.0 06:08:09 INFO - PROCESS | 5154 | 06:08:09 INFO - PROCESS | 5154 | [#4] audio-oscillator Cycles:10 Average:106.20 Median:93.00 stddev:21.28 (22.9%) stddev-sans-first:22.11 06:08:09 INFO - PROCESS | 5154 | Values: 94.0 93.0 139.0 92.0 92.0 94.0 136.0 93.0 93.0 136.0 06:08:09 INFO - PROCESS | 5154 | 06:08:09 INFO - PROCESS | 5154 | [#5] imaging-gaussian-blur Cycles:10 Average:110.30 Median:110.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 06:08:09 INFO - PROCESS | 5154 | Values: 110.0 111.0 110.0 110.0 110.0 110.0 110.0 111.0 110.0 111.0 06:08:09 INFO - PROCESS | 5154 | 06:08:09 INFO - PROCESS | 5154 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:1.56 (1.1%) stddev-sans-first:0.73 06:08:09 INFO - PROCESS | 5154 | Values: 151.0 146.0 147.0 147.0 146.0 148.0 147.0 146.0 146.0 146.0 06:08:09 INFO - PROCESS | 5154 | 06:08:09 INFO - PROCESS | 5154 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:97.00 stddev:0.85 (0.9%) stddev-sans-first:0.88 06:08:09 INFO - PROCESS | 5154 | Values: 96.0 95.0 96.0 96.0 97.0 96.0 97.0 97.0 97.0 98.0 06:08:09 INFO - PROCESS | 5154 | 06:08:09 INFO - PROCESS | 5154 | [#8] json-parse-financial Cycles:10 Average:61.00 Median:62.00 stddev:2.36 (3.8%) stddev-sans-first:2.50 06:08:09 INFO - PROCESS | 5154 | Values: 61.0 62.0 63.0 62.0 64.0 59.0 60.0 60.0 56.0 63.0 06:08:09 INFO - PROCESS | 5154 | 06:08:09 INFO - PROCESS | 5154 | [#9] json-stringify-tinderbox Cycles:10 Average:68.00 Median:68.00 stddev:1.33 (2.0%) stddev-sans-first:1.36 06:08:09 INFO - PROCESS | 5154 | Values: 67.0 71.0 68.0 67.0 69.0 67.0 69.0 67.0 67.0 68.0 06:08:09 INFO - PROCESS | 5154 | 06:08:09 INFO - PROCESS | 5154 | [#10] stanford-crypto-aes Cycles:10 Average:85.40 Median:85.50 stddev:2.32 (2.7%) stddev-sans-first:2.29 06:08:09 INFO - PROCESS | 5154 | Values: 83.0 91.0 86.0 87.0 86.0 84.0 84.0 84.0 85.0 84.0 06:08:09 INFO - PROCESS | 5154 | 06:08:09 INFO - PROCESS | 5154 | [#11] stanford-crypto-ccm Cycles:10 Average:124.10 Median:125.00 stddev:3.07 (2.5%) stddev-sans-first:2.92 06:08:09 INFO - PROCESS | 5154 | Values: 128.0 122.0 125.0 124.0 124.0 121.0 127.0 125.0 118.0 127.0 06:08:09 INFO - PROCESS | 5154 | 06:08:09 INFO - PROCESS | 5154 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.20 Median:157.00 stddev:8.60 (5.5%) stddev-sans-first:8.29 06:08:09 INFO - PROCESS | 5154 | Values: 144.0 163.0 168.0 147.0 159.0 144.0 155.0 161.0 155.0 146.0 06:08:09 INFO - PROCESS | 5154 | 06:08:09 INFO - PROCESS | 5154 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:69.50 stddev:1.57 (2.3%) stddev-sans-first:1.54 06:08:09 INFO - PROCESS | 5154 | Values: 67.0 70.0 71.0 69.0 69.0 67.0 70.0 70.0 67.0 67.0 06:08:09 INFO - PROCESS | 5154 | -------- Summary: end -------- 06:08:09 INFO - PROCESS | 5154 | 06:08:10 INFO - TEST-INFO | 5154: exit 0 06:08:10 INFO - TEST-OK | kraken | took 59588ms 06:08:10 INFO - TEST-START | v8_7 06:08:10 INFO - operating with platform_type : linux_ 06:08:10 INFO - Initialising browser for v8_7 test... 06:08:10 INFO - TEST-INFO | started process 5442 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpmwCVPb/profile http://localhost:57074/getInfo.html) 06:08:13 INFO - PROCESS | 5442 | JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 06:08:14 INFO - PROCESS | 5442 | __metrics Screen width/height:1600/1200 06:08:14 INFO - PROCESS | 5442 | colorDepth:24 06:08:14 INFO - PROCESS | 5442 | Browser inner width/height: 1024/670 06:08:14 INFO - PROCESS | 5442 | __metrics 06:08:14 INFO - PROCESS | 5442 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 06:08:15 INFO - TEST-INFO | 5442: exit 0 06:08:15 INFO - Browser initialized. 06:08:15 INFO - Running cycle 1/1 for v8_7 test... 06:08:15 INFO - TEST-INFO | started process 5567 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpmwCVPb/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:08:27 INFO - PROCESS | 5567 | RSS: Main: 151420928 06:08:27 INFO - PROCESS | 5567 | 06:08:48 INFO - PROCESS | 5567 | Cycle 1(1): loaded http://localhost:57074/tests/v8_7/run.html (next: http://localhost:57074/tests/v8_7/run.html) 06:08:49 INFO - PROCESS | 5567 | RSS: Main: 146989056 06:08:49 INFO - PROCESS | 5567 | 06:08:49 INFO - PROCESS | 5567 | __start_tp_report 06:08:49 INFO - PROCESS | 5567 | _x_x_mozilla_page_load 06:08:49 INFO - PROCESS | 5567 | _x_x_mozilla_page_load_details 06:08:49 INFO - PROCESS | 5567 | |i|pagename|runs| 06:08:49 INFO - PROCESS | 5567 | |0;Richards;167.78523489932886 06:08:49 INFO - PROCESS | 5567 | |1;DeltaBlue;187.86398647379298 06:08:49 INFO - PROCESS | 5567 | |2;Encrypt;279.79854504756577 06:08:49 INFO - PROCESS | 5567 | |3;Decrypt;5196.891191709845 06:08:49 INFO - PROCESS | 5567 | |4;RayTrace;1082.2510822510822 06:08:49 INFO - PROCESS | 5567 | |5;Earley;704.2253521126761 06:08:49 INFO - PROCESS | 5567 | |6;Boyer;12256.09756097561 06:08:49 INFO - PROCESS | 5567 | |7;RegExp;25525 06:08:49 INFO - PROCESS | 5567 | |8;Splay;684.2105263157895 06:08:49 INFO - PROCESS | 5567 | |9;NavierStokes;4835.748792270531 06:08:49 INFO - PROCESS | 5567 | __end_tp_report 06:08:49 INFO - PROCESS | 5567 | __startTimestamp1450706929002__endTimestamp 06:08:49 INFO - PROCESS | 5567 | 06:08:49 INFO - PROCESS | 5567 | ------- Summary: start ------- 06:08:49 INFO - PROCESS | 5567 | Number of tests: 10 06:08:49 INFO - PROCESS | 5567 | 06:08:49 INFO - PROCESS | 5567 | [#0] Richards Cycles:1 Average:167.79 Median:167.79 stddev:0.00 (0.0%) 06:08:49 INFO - PROCESS | 5567 | Values: 167.8 06:08:49 INFO - PROCESS | 5567 | 06:08:49 INFO - PROCESS | 5567 | [#1] DeltaBlue Cycles:1 Average:187.86 Median:187.86 stddev:0.00 (0.0%) 06:08:49 INFO - PROCESS | 5567 | Values: 187.9 06:08:49 INFO - PROCESS | 5567 | 06:08:49 INFO - PROCESS | 5567 | [#2] Encrypt Cycles:1 Average:279.80 Median:279.80 stddev:0.00 (0.0%) 06:08:49 INFO - PROCESS | 5567 | Values: 279.8 06:08:49 INFO - PROCESS | 5567 | 06:08:49 INFO - PROCESS | 5567 | [#3] Decrypt Cycles:1 Average:5196.89 Median:5196.89 stddev:0.00 (0.0%) 06:08:49 INFO - PROCESS | 5567 | Values: 5196.9 06:08:49 INFO - PROCESS | 5567 | 06:08:49 INFO - PROCESS | 5567 | [#4] RayTrace Cycles:1 Average:1082.25 Median:1082.25 stddev:0.00 (0.0%) 06:08:49 INFO - PROCESS | 5567 | Values: 1082.3 06:08:49 INFO - PROCESS | 5567 | 06:08:49 INFO - PROCESS | 5567 | [#5] Earley Cycles:1 Average:704.23 Median:704.23 stddev:0.00 (0.0%) 06:08:49 INFO - PROCESS | 5567 | Values: 704.2 06:08:49 INFO - PROCESS | 5567 | 06:08:49 INFO - PROCESS | 5567 | [#6] Boyer Cycles:1 Average:12256.10 Median:12256.10 stddev:0.00 (0.0%) 06:08:49 INFO - PROCESS | 5567 | Values: 12256.1 06:08:49 INFO - PROCESS | 5567 | 06:08:49 INFO - PROCESS | 5567 | [#7] RegExp Cycles:1 Average:25525.00 Median:25525.00 stddev:0.00 (0.0%) 06:08:49 INFO - PROCESS | 5567 | Values: 25525.0 06:08:49 INFO - PROCESS | 5567 | 06:08:49 INFO - PROCESS | 5567 | [#8] Splay Cycles:1 Average:684.21 Median:684.21 stddev:0.00 (0.0%) 06:08:49 INFO - PROCESS | 5567 | Values: 684.2 06:08:49 INFO - PROCESS | 5567 | 06:08:49 INFO - PROCESS | 5567 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 06:08:49 INFO - PROCESS | 5567 | Values: 4835.7 06:08:49 INFO - PROCESS | 5567 | -------- Summary: end -------- 06:08:49 INFO - PROCESS | 5567 | 06:08:49 INFO - TEST-INFO | 5567: exit 0 06:08:49 INFO - TEST-OK | v8_7 | took 39697ms 06:08:49 INFO - SUITE-END | took 1209s 06:08:50 INFO - Completed test suite (00:20:09) 06:08:50 INFO - Working with test: dromaeo_css 06:08:50 INFO - Generating results file: dromaeo_css 06:08:50 INFO - Working with test: kraken 06:08:50 INFO - Generating results file: kraken 06:08:50 INFO - javascript benchmark 06:08:50 INFO - Working with test: v8_7 06:08:50 INFO - Generating results file: v8_7 06:08:50 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:08:50 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,43]] 06:08:50 INFO - process_Request line: dromaeo_css 6750.61 graph.html#tests=[[72,1,43]] 06:08:50 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:08:50 INFO - process_Request line: kraken 1519.90 graph.html#tests=[[232,1,43]] 06:08:50 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:08:50 INFO - process_Request line: v8_7 21070.47 graph.html#tests=[[230,1,43]] 06:08:50 INFO - RETURN: dromaeo_css: 6750.61 06:08:50 INFO - RETURN: kraken: 1519.90 06:08:50 INFO - RETURN: v8_7: 21070.47 06:08:50 INFO - javascript benchmark 06:08:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3181.061586831884, 3193.696598823111, 3208.197950512372, 3216.8552415141316, 3231.1437469070693, 5323.0, 5403.7027963462, 5436.238926550282, 5466.863328416786, 5482.314710661168, 5382.273393091931, 5384.273123128377, 5425.3760817506, 5461.0, 5503.422140675221, 4699.506551812062, 4969.801207951687, 5143.09995750744, 5167.612429067816, 5179.326687530615, 4887.095887260868, 5102.515261050195, 5107.565856902168, 5128.974355128238, 5177.094008548508, 4923.064617722639, 4924.630652701044, 4927.852164435073, 4974.502549745032, 5073.137566613685, 4968.552830245295, 4981.227909674007, 4987.202047672355, 5006.774695138727, 5030.220315851012, 4949.7030178189425, 4992.375953005874, 5003.099442100421, 5003.674761140514, 5046.823361182378, 5147.0, 5208.192730126799, 5212.6611770235195, 5227.738613069331, 5333.866653333659, 5940.881182376328, 5982.880342393171, 5991.281046274431, 6009.849753756147, 6012.218411606463, 5864.76540938362, 6027.276726792769, 6030.4572588467245, 6035.185249991283, 6052.092186172065, 5567.777288908439, 5568.136938774496, 5616.719164041781, 5646.124850648156, 5699.145128230715, 6108.5418593605655, 6116.0, 6119.755209791648, 6128.724207410677, 6129.1419201311855, 5779.711014449261, 5896.086106653475, 5941.70291485424, 5946.048632218824, 5949.434803693643, 5886.470217680429, 5914.290285165807, 5971.701414929323, 5972.552058595623, 6030.758769649253, 5899.262592175978, 5899.7020655455735, 5903.911441328383, 5913.58604897653, 6015.819525414245, 5799.594028418054, 5904.4685978261305, 5907.172995780594, 5912.0, 5936.257967754031, 4515.841945531891, 4525.977370113194, 4534.115847409789, 4559.658025648089, 4579.0, 4008.398740188995, 4014.397840323916, 4044.5550989391145, 4048.1296521248073, 4051.513818341759, 5419.34967803866, 5474.5894057945015, 5514.503694667419, 5563.193336966117, 5580.2466666999435, 5942.405759424109, 5947.732352044169, 5966.582339236212, 5987.970060149759, 6019.307779605314, 5542.39033706292, 5558.666480011212, 5573.247611572467, 5620.044592419216, 5650.576206784508, 5051.494850514992, 5136.075506408883, 5141.331626888481, 5185.248139019896, 5283.392409872837, 6007.939920600738, 6014.398560144038, 6036.185115009417, 6057.60625559346, 6106.023036314168, 5960.493358064439, 5966.850828729316, 5968.373320801254, 5968.791092311748, 5983.102534619842, 5892.793752218652, 5938.703064846827, 6000.429959153874, 6018.789342373171, 6071.119687645179, 5851.9261176869695, 5875.0, 5902.557308201816, 5902.970485147547, 5908.763649453974, 5960.195373624505, 5973.104034394875, 6005.339412664691, 6011.068284415923, 6030.6080104793045, 5653.321601407857, 5698.601097923106, 5738.655680659007, 5752.194692742935, 5816.1857339973285, 5845.620034697731, 5921.17103605487, 5927.496162826208, 5930.733117009659, 5942.405759424196, 5463.48096930791, 5757.683327416865, 5762.94237057624, 5767.423257674199, 5769.884602308014, 5752.07966725322, 5797.30432348104, 5859.736311865891, 5884.823455296348, 5947.762089516544, 5719.57103217252, 5757.9424205757405, 5799.246098007232, 5804.912926306193, 5809.651420914759], "unit": "score", "name": "dojo.html", "value": 5454.480129556892}, {"lowerIsBetter": false, "replicates": [592.0645380299127, 593.0007936626785, 593.6022864680664, 596.9671668058257, 643.3020173112174, 37216.62783372166, 38279.234415311745, 38381.424278635845, 38412.80793596035, 38451.80774096129, 38849.0, 39279.803600981955, 39311.60688393122, 39464.210715785666, 39652.0, 8381.706640267592, 8483.363747718915, 8493.532855692934, 8534.402591818574, 8537.74386768398, 8358.582070896431, 8477.237048665618, 8489.490630562155, 8497.490150590984, 8510.404271700983, 8490.235878770909, 8532.146785321449, 8549.102344253857, 8576.957115214414, 8586.613602387908, 8448.028476725163, 8492.15078492152, 8498.362622803284, 8519.275861551776, 8519.53142577158, 8392.4544904581, 8499.660013599449, 8527.31781457488, 8529.53087580183, 8559.957200214021, 35892.64107358919, 35960.46059309113, 36146.45780313297, 36384.0, 36414.27171456556, 3235.466148085563, 3266.591676040495, 3526.647335266453, 3914.8629797956933, 4131.5042194936495, 28302.0, 28592.285192870346, 28981.85509072441, 29311.0, 30053.549196762066, 3270.509423586457, 3284.0640417480904, 3318.0, 3349.141813513014, 3420.3843308204514, 259575.0, 260689.69655151793, 263080.0, 263436.0, 263685.0, 40832.79583602122, 41612.37581436281, 54310.45689543133, 54507.72746136244, 54547.0, 39366.40950385747, 39392.409113863316, 39465.82937938384, 39583.40624890629, 39865.40201896974, 12513.0, 12613.30626815534, 12621.495140194473, 12624.305663188612, 12634.936825315815, 9918.40489570628, 9940.0, 9942.950285248528, 9943.751406214902, 9969.551370188214, 13936.58190254294, 13941.721165576835, 14056.297185140702, 14063.437462501386, 14150.433982640785, 5688.402717714663, 5696.971515142398, 5739.16782066598, 5843.152742852262, 5844.707764611752, 924.856647219682, 1023.0434543701663, 1025.7025462615907, 1043.6660268713938, 1080.5407701726892, 27935.720642793312, 28143.577846332322, 28230.85884570564, 28332.858335708603, 28392.574111388345, 1036.6112707734599, 1084.7884662490897, 1108.9741988660458, 1133.7165708572857, 1170.052257671289, 14608.707825843423, 14791.186484743443, 16561.42035028768, 16613.58466038359, 16766.58083547921, 369808.0, 377104.0, 377671.0, 378087.0, 378095.0, 52737.94524109496, 52824.47175528196, 52892.73553632284, 53047.46952530502, 53135.46864531305, 1334.379513526215, 1353.9593812185453, 1355.525566051874, 1358.130796290375, 1359.64649191211, 28361.574576380957, 28888.566671499524, 29221.269468263465, 29305.0, 29538.0, 42282.36576451294, 42729.78635106805, 42779.14441711086, 42881.57118428776, 42907.14185716206, 307281.0, 309359.0, 309495.0, 309640.0, 310207.0, 31098.53352199764, 43240.0, 43767.0, 44597.55402446064, 44795.77602111969, 41004.58995410127, 41712.95717607084, 42147.15705685808, 42324.0, 42469.0, 35349.46975795417, 35359.292814144086, 35583.82208088943, 36054.8197259012, 36860.447093294155, 34738.65261347354, 35784.0, 35803.28393432064, 35946.64053359433, 35955.82022089873, 34674.82662586772, 35378.46932296069, 35432.291354173285, 35446.64553354433, 35453.82273088618, 30596.541051884684, 31736.841315794198, 31974.52038219475, 32318.515222272155, 32549.186270342485, 24608.138715144883, 24614.753852461246, 25067.87466062658, 25333.87333063323, 25382.746172538038], "unit": "score", "name": "ext.html", "value": 17706.844463922764}, {"lowerIsBetter": false, "replicates": [354.80840346213046, 357.6244942810052, 360.55291438616126, 360.72584835525004, 361.49571347969584, 16300.673986520278, 17223.569410764736, 17454.389096381597, 18177.4546763597, 18258.634827303464, 10184.898151018506, 10229.386236825796, 10235.641752538662, 10562.366258024524, 10621.309614875046, 4723.2442809150625, 4840.249761286988, 4853.174960256747, 4866.367372241603, 4959.57843583294, 5249.711265880375, 5279.656822306557, 5280.894382112356, 5293.232481290211, 5301.496357846017, 5010.073136469765, 5175.663581867167, 5241.947580524203, 5263.631545791796, 5265.052290587692, 5171.379434467869, 5178.637495375326, 5180.9740951295, 5246.2917506136755, 5249.1338929076655, 4961.776720047606, 5091.338126043628, 5105.055564720538, 5116.079105760961, 5116.667416617908, 11621.825672614917, 11748.471318790675, 12199.695007624792, 19840.702389464168, 19891.80108198914, 1996.8402527797741, 2064.917403303866, 2069.4102180878376, 2081.4067990622752, 2201.768814274494, 8999.5050272235, 9188.678396256166, 9222.584983675752, 9230.492322922237, 9253.167214950687, 1710.6236627941832, 1773.7162054071416, 1793.5426466251154, 1812.5378028602754, 1825.853931685462, 60113.39886601165, 60186.9906504673, 63958.0, 64418.0, 65543.67228163828, 9665.613375465044, 9846.409215447096, 9874.506274686237, 9954.701358959242, 9975.900240997642, 12650.177738447155, 12677.87322126767, 12727.427265773062, 12739.490420383267, 12761.553345632858, 6799.7960061197255, 6810.046593476917, 6847.589144651237, 6895.138107736533, 6923.5499692519825, 6459.741610335534, 6474.1907261592305, 6480.2547707013355, 6498.155239818793, 6520.47836173105, 4190.245755763992, 4225.9788701056295, 4227.661787057028, 4228.534861165269, 4262.147570485915, 1720.380662961333, 1747.493226964166, 1761.409927674218, 1773.9467815965543, 1785.1698959983669, 376.095490345719, 409.1857204163752, 413.2932685108498, 428.0903080952975, 950.7860731335394, 8920.375573709778, 10029.799404012025, 10287.845682314772, 10380.273380863418, 10399.792004159874, 405.2935901183659, 406.778305823327, 411.695345444369, 419.5552714123039, 424.0839786062153, 5409.29679141709, 5498.230247765316, 5537.640053396516, 5563.415841336601, 5567.109262517978, 571033.0, 571464.0, 576228.0, 576618.0, 583177.0, 82388.0, 82955.58522207351, 84142.0, 84494.57752711196, 84722.0, 441.7813182474696, 443.70271917814495, 443.77589317394506, 445.99777001114785, 447.75373544550365, 9389.061093890556, 9555.378900371454, 9566.186874115778, 9577.377470464398, 9641.903580964381, 31828.36343273168, 32889.83555082305, 33228.50157247595, 33528.32943341168, 33839.49240761341, 48752.0, 49633.50366496289, 49889.25166122583, 50099.74950125226, 53207.20189197088, 8709.564521773758, 8889.64441422336, 8996.145366190201, 9157.404768690014, 9157.679481218125, 10545.736356591147, 10559.472026398804, 10590.8411373831, 16718.66562668764, 17042.914785425994, 8650.091740367423, 8910.643574256957, 13699.520516781864, 13781.104228225133, 13959.162450253018, 9109.498977556297, 9417.246620270498, 9475.810483790423, 9641.566129524048, 9684.46735429558, 9164.495952722664, 9496.335256531976, 9800.901990980285, 10223.131033862204, 10231.232657550863, 14494.420223190955, 14516.637084072983, 15010.174440405446, 15101.546953591409, 15421.383144674535, 15327.61680957985, 15472.767908481157, 15655.608609784846, 15787.0, 16128.354865805706], "unit": "score", "name": "jquery.html", "value": 7532.143426904275}, {"lowerIsBetter": false, "replicates": [1415.2569900802077, 1476.453712126513, 1558.2208895552224, 1615.3054186699715, 1706.5818874375786, 7750.7674769756995, 7861.410394220435, 7905.841883162333, 8087.959560202198, 8098.149694282104, 7974.96012519938, 8097.311728503084, 8154.836903261946, 8165.795855103611, 8166.877496837537, 2233.6426171812554, 2271.114265436481, 2279.407354087941, 2292.5071109711407, 2293.334932869466, 2241.977580224201, 2259.3109101723967, 2309.8498597591188, 2313.0400883633274, 2316.791488766011, 2227.8329125315668, 2231.787980141892, 2234.1175235781857, 2248.6402175651897, 2263.6378179491285, 2206.5366273082673, 2237.6196046672026, 2243.6410174372186, 2250.7861753133425, 2251.6960210371553, 2232.140625859056, 2232.2968264996475, 2247.898844551999, 2252.087904398721, 2265.66015097735, 7729.806754831118, 7886.566238856861, 7936.761897143095, 7948.5628290444, 7963.482373645695, 4566.223741963841, 4587.587117159472, 4630.699004564693, 4646.53534646536, 4666.6966647168165, 2945.0, 2955.2020954342424, 2993.311538346171, 3007.7593792496546, 3012.9397412051853, 862.4825104936988, 866.1035827918138, 890.8975467821218, 911.9635214591408, 928.2991341537096, 10911.0, 10933.289336193202, 10962.616308429167, 10963.56145754169, 10985.395803230818, 3965.7025723070883, 4045.8381664733083, 4091.959080409217, 4102.466679331727, 4126.793660316972, 8703.608337624695, 8764.0, 8784.429012114193, 8821.294296456268, 8899.377043606886, 4589.173948689268, 4615.515370886009, 4626.421697287839, 4648.3259927310355, 4659.883502912387, 4255.319148936217, 4276.550962148992, 4295.6778241632, 4299.785010749512, 4317.0, 3383.9661603384143, 3434.072800343893, 3446.603640581315, 3449.9482507762405, 3460.3598334308235, 998.1814911772423, 1008.7578981044496, 1010.6967909627083, 1016.3089099412323, 1018.1956254558963, 957.3250858144991, 959.8032403357295, 1068.8396740488988, 1085.9945700271605, 1271.1483306184878, 7447.218042105609, 7486.737964171228, 7488.138864030598, 7520.736774212876, 7540.359069479046, 1073.613499140309, 1097.4293367448881, 1131.140333346646, 1132.4394424759796, 1142.2175809570472, 5907.881842363128, 5917.704114794243, 5948.750762339871, 5992.790252341147, 6009.128676341906, 8447.66209351619, 8568.828623427496, 8591.05498395176, 8638.913610863936, 8937.642494300286, 9106.590203440861, 9237.769055773659, 9240.7689807754, 9328.906710932939, 9383.296252780932, 7242.818929526804, 7256.637168141572, 7306.415486761046, 7329.377002954702, 7376.889346659805, 6925.099737034153, 6976.825579360557, 6985.266547012694, 6988.79033628992, 7010.719571217094, 7646.617669116633, 7881.487703299267, 7895.64469598858, 7896.249856263646, 7990.0, 7939.166387529226, 7982.8004299890645, 7982.960085199769, 8103.108658047492, 8152.144024877302, 6708.597484150967, 6795.93204067953, 6969.721211151497, 6975.930240697731, 6982.825429364307, 7407.703691852265, 7444.0, 7461.104667439942, 7477.88783168242, 7517.135529414188, 6896.689648965909, 7063.858722825617, 7101.573905565682, 7110.14678238594, 7207.0, 6552.180977377828, 6586.1438013059915, 6816.897746533707, 6822.044913711985, 6914.861702765816, 6651.368120028589, 6894.0, 6903.965480172567, 6960.9303906962305, 6968.547044442095, 5731.168980497888, 6015.0, 6075.483583895419, 6083.270007599116, 6341.302456729848, 6023.548233882389, 6064.241969753781, 6105.908411373922, 6108.694565271808, 6114.602550834182], "unit": "score", "name": "mootools.html", "value": 4386.565922600024}, {"lowerIsBetter": false, "replicates": [309.9225193701575, 311.79265788250814, 313.37168976202736, 315.9668234835341, 317.6378928022055, 6284.654344011084, 6323.241211054668, 6434.195725534309, 6491.058796474508, 6515.543911926161, 6270.153529273547, 6315.557910946224, 6325.272593651732, 6329.936700633004, 6333.20834895638, 4593.553030795306, 4713.057388522309, 4714.245720684691, 4735.85792426226, 4756.405449318835, 4697.295405689139, 4710.97644511777, 4715.41057367829, 4716.622670186394, 4726.763661816913, 4682.555157260055, 4683.110209060268, 4684.812607495696, 4687.695299805502, 4688.484266730674, 4693.953060469403, 4701.153792317382, 4708.74101924394, 4712.481627021025, 4714.7642617869315, 3940.704447166474, 4041.1109555897656, 4049.6152865477734, 4055.4119652650497, 4057.3102572562734, 5867.266591676041, 5916.26046744157, 5954.732037058343, 5961.195238642771, 5982.0727787193055, 5400.837974860721, 5455.5908306877145, 5460.099083651193, 5467.507924286833, 5477.780888764445, 6605.9339406605795, 6629.767958121491, 6640.93359066408, 6643.501737369668, 6653.4344580710695, 4335.913281734379, 4455.688101832873, 4457.108578284324, 4464.955350446487, 4473.575010374042, 6829.692663830139, 6883.449324054114, 6896.344847239504, 6904.171499420051, 6915.997180408863, 4543.250363689954, 4555.931661025087, 4560.88597785058, 4567.36056952027, 4577.862664120082, 4425.203463376559, 4628.39830821991, 4636.420447444069, 4638.79125439356, 4644.396228490275, 5393.7303134843105, 5399.676019438846, 5400.594955378362, 5400.945990540123, 5402.864928376822, 6618.073469714244, 6676.0, 6682.398584127452, 6683.732650694015, 6683.832904177434, 1627.397862790775, 1627.5524230836377, 1627.5849658337286, 1633.1752465005097, 1634.1502418742425, 1064.1539975719322, 1072.5656109275756, 1075.408525311076, 1089.8310761831929, 1097.5006372100675, 6218.067289906459, 6328.588641738273, 6369.490440764727, 6374.936250637527, 6383.457406120532, 6876.484263680244, 6957.61733104674, 7000.2999700030605, 7003.474739394565, 7007.019017337577, 6373.52198585108, 6413.0, 6432.0, 6433.906235939901, 6436.613803171825, 3661.41417373219, 3767.1900541383184, 3787.8295476703615, 3795.5065841440437, 3796.563395209531, 7010.263922288188, 7027.297270273034, 7060.7881763547175, 7107.111611048619, 7124.145102587722, 7153.856922861513, 7164.319389657974, 7180.497365184491, 7192.856142877114, 7195.640217989079, 6914.377706006484, 7053.823654408681, 7086.858262834715, 7130.288730704698, 7165.462590305644, 6989.405900498515, 6990.790276291719, 7002.334778196063, 7015.508914376149, 7032.648367581703, 6902.413294869792, 6925.826854328682, 6936.583804971718, 6938.5143039986715, 6944.826379340557, 6852.314768523108, 7120.0387947626405, 7121.4302855770375, 7123.0, 7123.715051397886, 4564.634829213722, 4592.793324300348, 4592.862214133581, 4599.241125214302, 4603.884902877455, 6966.79099627012, 6998.2651821558, 6999.0551275577145, 7014.158301003912, 7023.859522809617, 6590.077389165424, 6733.124693789776, 6793.388595026471, 6828.385445309946, 6833.0, 6751.189857217166, 6766.05275261454, 6768.120144381396, 6786.558873673195, 6797.810383183022, 6449.032645103272, 6547.345265473415, 6583.539152259296, 6590.2421221560135, 6607.702653380706, 6634.170728658918, 6756.459483241427, 6829.146356705412, 6830.112085428863, 6857.485688573477, 6527.2167339919515, 6534.019897015486, 6543.051257567721, 6547.836304092436, 6672.666366681744], "unit": "score", "name": "prototype.html", "value": 4976.783780859333}, {"lowerIsBetter": false, "replicates": [705.326413275322, 709.8580283943213, 716.802879208218, 778.136268741697, 801.20680526279, 13056.412461439235, 13443.932780336085, 13538.39077241524, 13542.661433464156, 13606.115602485832, 12426.937865310683, 12969.286689232089, 13146.539871104513, 13169.144005639626, 13241.0, 816.2245866426889, 822.576373167819, 824.0194168938973, 825.9091499935003, 826.446280991737, 812.3988248695981, 816.7304789419507, 823.4400607586839, 825.0511911301991, 827.548985802736, 857.391252210931, 860.8278344331128, 861.9525926074064, 863.8574635185187, 868.5483548554748, 840.756180707591, 847.9406441549094, 850.3962186847345, 854.3549620036863, 857.691231156783, 626.4894111299277, 627.8179327994876, 630.0, 635.3138610300864, 636.226984214182, 12652.17760845542, 12697.428615712315, 12726.300053497054, 12730.23618582888, 12834.679133021657, 10555.788884222273, 10605.734856628646, 10840.0, 10960.616378426717, 11135.610253641165, 8481.0, 8542.0, 8609.526476043815, 8671.523066231355, 8969.416987895765, 3264.722498587623, 3349.2631621043333, 3369.528266042756, 3422.3839708852397, 3438.5014172944784, 41127.588724112975, 43325.0, 44057.55942440566, 48877.511224887654, 49768.50231497675, 8539.615717292736, 8792.648294068293, 8936.195742383086, 8952.641894324153, 9396.577154028086, 17815.0, 17860.19629116693, 17863.46409607714, 17975.640487190183, 17986.460406187834, 7372.852542949218, 7468.3278504934815, 7486.438517111238, 7565.735199268, 7623.275788800055, 3504.369213541587, 3688.5204923359793, 3773.4339849022317, 3778.1499162688174, 3812.4853144825647, 2756.9172924812287, 2850.087971848988, 2857.8142420742583, 2865.5271880139962, 2874.2670618992443, 495.5960891873112, 497.76604995651985, 500.2346409992717, 506.172408112731, 520.3911423634357, 579.5161040531119, 592.9525637948954, 596.31126049413, 610.6671863834221, 634.7016902056026, 7335.816604584928, 7573.129090154703, 7676.309132178131, 7703.34521565662, 7723.150453450116, 609.1928195141455, 615.1480199923138, 635.6916895305866, 642.9421352078335, 647.3138473218404, 3529.1882866940746, 3632.2917031179195, 3644.453332000221, 3653.634636536325, 3661.23114146027, 57579.42420575741, 57658.98193563289, 57670.423295767345, 58487.70756146192, 58822.41177588255, 47888.0, 48845.75577122163, 49533.0, 50054.74972625187, 50135.0, 45946.54053459423, 47889.0, 48284.75857620689, 48725.51274487281, 49630.0, 7790.0, 7900.367970562456, 7939.483933544301, 7993.600319984093, 8103.594820259082, 33891.66108338885, 34319.656803431644, 34675.4798678015, 34861.0, 34970.65029349674, 39459.80270098746, 42694.78652606717, 42989.78505107579, 43407.34888976605, 43515.129697406504, 9750.414975101517, 10064.0, 10204.795904081728, 10362.326448780805, 10441.634542790965, 10761.408122553335, 11017.1186305097, 11036.061934735317, 11153.832692509457, 11242.66272011841, 10136.695899123039, 10353.534090965773, 10436.37381757097, 10444.321119127233, 10987.0, 10066.295359324777, 10112.89887101149, 10385.740356491147, 10772.084372828398, 10795.0, 10197.971706998096, 10353.844692329772, 10480.318779279323, 10495.580176792842, 10540.841887371542, 9165.495897725688, 9278.907210928075, 9304.302177336862, 9540.761480963032, 9549.761255968378, 8015.318697910743, 8041.959790201012, 8269.793255168668, 8721.080586444887, 9108.681196158368], "unit": "score", "name": "yui.html", "value": 5958.522212902665}], "name": "dromaeo_css", "value": 6750.615059276925}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 107.0, 112.0, 110.0, 111.0, 125.0, 111.0, 111.0, 112.0, 112.0], "unit": "score", "name": "ai-astar", "value": 112.3}, {"lowerIsBetter": true, "replicates": [157.0, 126.0, 153.0, 164.0, 125.0, 155.0, 149.0, 127.0, 164.0, 125.0], "unit": "score", "name": "audio-beat-detection", "value": 144.5}, {"lowerIsBetter": true, "replicates": [164.0, 163.0, 162.0, 163.0, 162.0, 161.0, 161.0, 162.0, 174.0, 163.0], "unit": "score", "name": "audio-dft", "value": 163.5}, {"lowerIsBetter": true, "replicates": [71.0, 74.0, 71.0, 73.0, 72.0, 72.0, 133.0, 72.0, 73.0, 71.0], "unit": "score", "name": "audio-fft", "value": 78.2}, {"lowerIsBetter": true, "replicates": [94.0, 93.0, 139.0, 92.0, 92.0, 94.0, 136.0, 93.0, 93.0, 136.0], "unit": "score", "name": "audio-oscillator", "value": 106.2}, {"lowerIsBetter": true, "replicates": [110.0, 111.0, 110.0, 110.0, 110.0, 110.0, 110.0, 111.0, 110.0, 111.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.3}, {"lowerIsBetter": true, "replicates": [151.0, 146.0, 147.0, 147.0, 146.0, 148.0, 147.0, 146.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 147.0}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 96.0, 96.0, 97.0, 96.0, 97.0, 97.0, 97.0, 98.0], "unit": "score", "name": "imaging-desaturate", "value": 96.5}, {"lowerIsBetter": true, "replicates": [61.0, 62.0, 63.0, 62.0, 64.0, 59.0, 60.0, 60.0, 56.0, 63.0], "unit": "score", "name": "json-parse-financial", "value": 61.0}, {"lowerIsBetter": true, "replicates": [67.0, 71.0, 68.0, 67.0, 69.0, 67.0, 69.0, 67.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.0}, {"lowerIsBetter": true, "replicates": [83.0, 91.0, 86.0, 87.0, 86.0, 84.0, 84.0, 84.0, 85.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.4}, {"lowerIsBetter": true, "replicates": [128.0, 122.0, 125.0, 124.0, 124.0, 121.0, 127.0, 125.0, 118.0, 127.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.1}, {"lowerIsBetter": true, "replicates": [144.0, 163.0, 168.0, 147.0, 159.0, 144.0, 155.0, 161.0, 155.0, 146.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 154.2}, {"lowerIsBetter": true, "replicates": [67.0, 70.0, 71.0, 69.0, 69.0, 67.0, 70.0, 70.0, 67.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.7}], "name": "kraken", "value": 1519.9}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.78523489932886], "unit": "score", "name": "Richards", "value": 210.39992}, {"lowerIsBetter": false, "replicates": [187.86398647379298], "unit": "score", "name": "DeltaBlue", "value": 351.946114}, {"lowerIsBetter": false, "replicates": [279.79854504756577], "unit": "score", "name": "Encrypt", "value": 951.330894}, {"lowerIsBetter": false, "replicates": [5196.891191709845], "unit": "score", "name": "Decrypt", "value": 51.219275174476564}, {"lowerIsBetter": false, "replicates": [1082.2510822510822], "unit": "score", "name": "RayTrace", "value": 683.7498360000003}, {"lowerIsBetter": false, "replicates": [704.2253521126761], "unit": "score", "name": "Earley", "value": 946.3774600000002}, {"lowerIsBetter": false, "replicates": [12256.09756097561], "unit": "score", "name": "Boyer", "value": 54.378075621890574}, {"lowerIsBetter": false, "replicates": [25525.0], "unit": "score", "name": "RegExp", "value": 35.689911851126354}, {"lowerIsBetter": false, "replicates": [684.2105263157895], "unit": "score", "name": "Splay", "value": 119.10223076923077}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 21070.47283333757}]} 06:08:50 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,43]]", "result": "21070.47"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,43]]", "result": "1519.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,43]]", "result": "6750.61"}}} 06:08:50 INFO - Return code: 0 06:08:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 06:08:50 INFO - # TBPL SUCCESS # 06:08:50 INFO - Running post-action listener: _resource_record_post_action 06:08:50 INFO - Running post-run listener: _resource_record_post_run 06:08:51 INFO - Total resource usage - Wall time: 1226s; CPU: 13.0%; Read bytes: 20480; Write bytes: 565272576; Read time: 16; Write time: 548740 06:08:51 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 242720768; Read time: 0; Write time: 338716 06:08:51 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 20480; Write bytes: 322551808; Read time: 16; Write time: 210024 06:08:51 INFO - Running post-run listener: _upload_blobber_files 06:08:51 INFO - Blob upload gear active. 06:08:51 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 06:08:51 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 06:08:51 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'] 06:08:51 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 06:08:51 INFO - (blobuploader) - INFO - Open directory for files ... 06:08:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:08:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:08:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:08:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:08:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:08:52 INFO - (blobuploader) - INFO - Done attempting. 06:08:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:08:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:08:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:08:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:08:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:08:53 INFO - (blobuploader) - INFO - Done attempting. 06:08:53 INFO - (blobuploader) - INFO - Iteration through files over. 06:08:53 INFO - Return code: 0 06:08:53 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 06:08:53 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 06:08:53 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ce6f4bbb1f77dc37c7af9d6b6caf47d29377fcd57c77b342342c63d6f8d0bc5591efd3185c6556043dc355ac78b85d857923fe93e8a84d871546895219fe3b39", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f1e8f8a8c47b277f2a040cf613920e14ac36e4098ba602185fb7da891e7efd524b58b8a374f06478e9bbb7dd9b51cab93b9cf4eff7fe4fb14562837361821a5f"} 06:08:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 06:08:53 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 06:08:53 INFO - Contents: 06:08:53 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ce6f4bbb1f77dc37c7af9d6b6caf47d29377fcd57c77b342342c63d6f8d0bc5591efd3185c6556043dc355ac78b85d857923fe93e8a84d871546895219fe3b39", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f1e8f8a8c47b277f2a040cf613920e14ac36e4098ba602185fb7da891e7efd524b58b8a374f06478e9bbb7dd9b51cab93b9cf4eff7fe4fb14562837361821a5f"} 06:08:53 INFO - Copying logs to upload dir... 06:08:53 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1267.074591 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2015-12-21 06:08:52.491359) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-21 06:08:52.494418) ========= 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=6b42339bb4b96cfc3b1ae7e5000001a3-1450704811.202200-114231841 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ce6f4bbb1f77dc37c7af9d6b6caf47d29377fcd57c77b342342c63d6f8d0bc5591efd3185c6556043dc355ac78b85d857923fe93e8a84d871546895219fe3b39", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f1e8f8a8c47b277f2a040cf613920e14ac36e4098ba602185fb7da891e7efd524b58b8a374f06478e9bbb7dd9b51cab93b9cf4eff7fe4fb14562837361821a5f"} build_url:https://queue.taskcluster.net/v1/task/R2JY63BaSd-7ZdG_XF8aag/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011260 build_url: 'https://queue.taskcluster.net/v1/task/R2JY63BaSd-7ZdG_XF8aag/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ce6f4bbb1f77dc37c7af9d6b6caf47d29377fcd57c77b342342c63d6f8d0bc5591efd3185c6556043dc355ac78b85d857923fe93e8a84d871546895219fe3b39", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f1e8f8a8c47b277f2a040cf613920e14ac36e4098ba602185fb7da891e7efd524b58b8a374f06478e9bbb7dd9b51cab93b9cf4eff7fe4fb14562837361821a5f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-21 06:08:52.518899) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 06:08:52.519235) ========= 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=6b42339bb4b96cfc3b1ae7e5000001a3-1450704811.202200-114231841 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004561 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 06:08:52.602885) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-21 06:08:52.603202) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-21 06:08:52.603483) ========= ========= Total master_lag: 0.29 =========