builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-058 starttime: 1450832629.67 results: success (0) buildid: 20151222143005 builduid: 8aa7d3ed96f34592b8b153024e64d230 revision: 645cb0f2d2836e5daddff06665bbd306a8b9093d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-22 17:03:49.665590) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-22 17:03:49.666163) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-22 17:03:49.666474) ========= 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=e25b24362c3bb3dea6e300e4000001c1-1450831259.767204-550062830 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006384 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-22 17:03:49.690971) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-22 17:03:49.691285) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-22 17:03:49.721010) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 17:03:49.721375) ========= 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=e25b24362c3bb3dea6e300e4000001c1-1450831259.767204-550062830 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004633 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 17:03:49.771221) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-22 17:03:49.771535) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-22 17:03:49.771896) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 17:03:49.772179) ========= 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=e25b24362c3bb3dea6e300e4000001c1-1450831259.767204-550062830 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-22 17:03:50-- 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% 214M=0s 2015-12-22 17:03:50 (214 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.174857 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 17:03:49.965960) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 17:03:49.966228) ========= 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=e25b24362c3bb3dea6e300e4000001c1-1450831259.767204-550062830 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017754 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 17:03:50.015256) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-22 17:03:50.015622) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 645cb0f2d2836e5daddff06665bbd306a8b9093d --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 645cb0f2d2836e5daddff06665bbd306a8b9093d --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=e25b24362c3bb3dea6e300e4000001c1-1450831259.767204-550062830 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-22 17:03:50,690 truncating revision to first 12 chars 2015-12-22 17:03:50,690 Setting DEBUG logging. 2015-12-22 17:03:50,690 attempt 1/10 2015-12-22 17:03:50,690 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/645cb0f2d283?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-22 17:03:51,953 unpacking tar archive at: fx-team-645cb0f2d283/testing/mozharness/ program finished with exit code 0 elapsedTime=1.559517 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-22 17:03:51.587784) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-22 17:03:51.588087) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-22 17:03:51.598215) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-22 17:03:51.598590) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-22 17:03:51.599018) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2015-12-22 17:03:51.599299) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e25b24362c3bb3dea6e300e4000001c1-1450831259.767204-550062830 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:03:52 INFO - MultiFileLogger online at 20151222 17:03:52 in /builds/slave/test-pgo 17:03:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 17:03:52 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 17:03:52 INFO - {'append_to_log': False, 17:03:52 INFO - 'base_work_dir': '/builds/slave/test-pgo', 17:03:52 INFO - 'blob_upload_branch': 'Fx-Team', 17:03:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 17:03:52 INFO - 'branch': 'Fx-Team', 17:03:52 INFO - 'buildbot_json_path': 'buildprops.json', 17:03:52 INFO - 'config_files': ('talos/linux_config.py',), 17:03:52 INFO - 'default_actions': ('clobber', 17:03:52 INFO - 'read-buildbot-config', 17:03:52 INFO - 'download-and-extract', 17:03:52 INFO - 'populate-webroot', 17:03:52 INFO - 'create-virtualenv', 17:03:52 INFO - 'install', 17:03:52 INFO - 'run-tests'), 17:03:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:03:52 INFO - 'download_minidump_stackwalk': True, 17:03:52 INFO - 'download_symbols': 'ondemand', 17:03:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:03:52 INFO - 'tooltool.py': '/tools/tooltool.py', 17:03:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:03:52 INFO - '/tools/misc-python/virtualenv.py')}, 17:03:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:03:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:03:52 INFO - 'installer_path': 'installer.exe', 17:03:52 INFO - 'log_level': 'info', 17:03:52 INFO - 'log_name': 'talos', 17:03:52 INFO - 'log_to_console': True, 17:03:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:03:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:03:52 INFO - 'opt_config_files': (), 17:03:52 INFO - 'pip_index': False, 17:03:52 INFO - 'sps_profile': False, 17:03:52 INFO - 'sps_profile_interval': 0, 17:03:52 INFO - 'suite': 'dromaeojs', 17:03:52 INFO - 'system_bits': '64', 17:03:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:03:52 INFO - 'title': 'talos-linux64-ix-058', 17:03:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:03:52 INFO - 'use_talos_json': True, 17:03:52 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 17:03:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:03:52 INFO - 'work_dir': 'build'} 17:03:52 INFO - ##### 17:03:52 INFO - ##### Running clobber step. 17:03:52 INFO - ##### 17:03:52 INFO - Running pre-action listener: _resource_record_pre_action 17:03:52 INFO - Running main action method: clobber 17:03:52 INFO - rmtree: /builds/slave/test-pgo/build 17:03:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 17:03:53 INFO - Running post-action listener: _resource_record_post_action 17:03:53 INFO - ##### 17:03:53 INFO - ##### Running read-buildbot-config step. 17:03:53 INFO - ##### 17:03:53 INFO - Running pre-action listener: _resource_record_pre_action 17:03:53 INFO - Running main action method: read_buildbot_config 17:03:53 INFO - Using buildbot properties: 17:03:53 INFO - { 17:03:53 INFO - "project": "", 17:03:53 INFO - "product": "firefox", 17:03:53 INFO - "script_repo_revision": "production", 17:03:53 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 17:03:53 INFO - "repository": "", 17:03:53 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 17:03:53 INFO - "buildid": "20151222143005", 17:03:53 INFO - "pgo_build": "True", 17:03:53 INFO - "basedir": "/builds/slave/test-pgo", 17:03:53 INFO - "buildnumber": 556, 17:03:53 INFO - "slavename": "talos-linux64-ix-058", 17:03:53 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 17:03:53 INFO - "platform": "ubuntu64_hw", 17:03:53 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 17:03:53 INFO - "branch": "fx-team", 17:03:53 INFO - "repo_path": "integration/fx-team", 17:03:53 INFO - "revision": "645cb0f2d2836e5daddff06665bbd306a8b9093d", 17:03:53 INFO - "stage_platform": "linux64-pgo", 17:03:53 INFO - "builduid": "8aa7d3ed96f34592b8b153024e64d230", 17:03:53 INFO - "slavebuilddir": "test" 17:03:53 INFO - } 17:03:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/JDjODWhqTOqY6mOmBWxxMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 17:03:53 INFO - Running post-action listener: _resource_record_post_action 17:03:53 INFO - ##### 17:03:53 INFO - ##### Running download-and-extract step. 17:03:53 INFO - ##### 17:03:53 INFO - Running pre-action listener: _resource_record_pre_action 17:03:53 INFO - Running main action method: download_and_extract 17:03:53 INFO - mkdir: /builds/slave/test-pgo/build/tests 17:03:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:03:53 INFO - https://queue.taskcluster.net/v1/task/JDjODWhqTOqY6mOmBWxxMw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 17:03:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDjODWhqTOqY6mOmBWxxMw/artifacts/public/build/test_packages.json 17:03:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDjODWhqTOqY6mOmBWxxMw/artifacts/public/build/test_packages.json 17:03:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDjODWhqTOqY6mOmBWxxMw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 17:03:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDjODWhqTOqY6mOmBWxxMw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 17:03:54 INFO - Downloaded 1302 bytes. 17:03:54 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 17:03:54 INFO - Using the following test package requirements: 17:03:54 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 17:03:54 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:03:54 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:03:54 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:03:54 INFO - u'jsshell-linux-x86_64.zip'], 17:03:54 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:03:54 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:03:54 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 17:03:54 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:03:54 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:03:54 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:03:54 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:03:54 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:03:54 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:03:54 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 17:03:54 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:03:54 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:03:54 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:03:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:03:54 INFO - https://queue.taskcluster.net/v1/task/JDjODWhqTOqY6mOmBWxxMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:03:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDjODWhqTOqY6mOmBWxxMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:03:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDjODWhqTOqY6mOmBWxxMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:03:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDjODWhqTOqY6mOmBWxxMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:03:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDjODWhqTOqY6mOmBWxxMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:03:56 INFO - Downloaded 23176547 bytes. 17:03:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 17:03:56 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:03:56 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 17:03:57 INFO - Return code: 0 17:03:57 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:03: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')]} 17:03:57 INFO - https://queue.taskcluster.net/v1/task/JDjODWhqTOqY6mOmBWxxMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:03:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDjODWhqTOqY6mOmBWxxMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:03:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDjODWhqTOqY6mOmBWxxMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:03:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDjODWhqTOqY6mOmBWxxMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:03:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDjODWhqTOqY6mOmBWxxMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:03:58 INFO - Downloaded 23176547 bytes. 17:03:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 17:03:58 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:03:58 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 17:03:59 INFO - Return code: 0 17:03:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:03:59 INFO - https://queue.taskcluster.net/v1/task/JDjODWhqTOqY6mOmBWxxMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:03:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDjODWhqTOqY6mOmBWxxMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 17:03:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDjODWhqTOqY6mOmBWxxMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 17:03:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDjODWhqTOqY6mOmBWxxMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 17:03:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDjODWhqTOqY6mOmBWxxMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:04:01 INFO - Downloaded 11132277 bytes. 17:04:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 17:04:01 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 17:04:01 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 17:04:01 INFO - Return code: 0 17:04:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:01 INFO - https://queue.taskcluster.net/v1/task/JDjODWhqTOqY6mOmBWxxMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:04:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDjODWhqTOqY6mOmBWxxMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:04:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDjODWhqTOqY6mOmBWxxMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:04:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDjODWhqTOqY6mOmBWxxMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:04:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDjODWhqTOqY6mOmBWxxMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:04:04 INFO - Downloaded 54924809 bytes. 17:04:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JDjODWhqTOqY6mOmBWxxMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:04:04 INFO - mkdir: /builds/slave/test-pgo/properties 17:04:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 17:04:04 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 17:04:04 INFO - Contents: 17:04:04 INFO - build_url:https://queue.taskcluster.net/v1/task/JDjODWhqTOqY6mOmBWxxMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:04:04 INFO - Running post-action listener: _resource_record_post_action 17:04:04 INFO - Running post-action listener: set_extra_try_arguments 17:04:04 INFO - ##### 17:04:04 INFO - ##### Running populate-webroot step. 17:04:04 INFO - ##### 17:04:04 INFO - Running pre-action listener: _resource_record_pre_action 17:04:04 INFO - Running main action method: populate_webroot 17:04:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:04:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:04:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:04:04 INFO - '--tppagecycles', 17:04:04 INFO - '7'], 17:04:04 INFO - 'tests': ['tsvgm']}}, 17:04:04 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:04:04 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:04:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:04:04 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:04:04 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:04:04 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:04:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:04:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:04:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:04:04 INFO - 'talos_options': ['--e10s'], 17:04:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:04:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:04:04 INFO - 'tests': ['damp', 'tps']}, 17:04:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:04:04 INFO - 'talos_options': ['--e10s'], 17:04:04 INFO - 'tests': ['damp', 'tps']}, 17:04:04 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:04:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:04:04 INFO - 'other': {'tests': ['a11yr', 17:04:04 INFO - 'ts_paint', 17:04:04 INFO - 'tpaint', 17:04:04 INFO - 'sessionrestore', 17:04:04 INFO - 'sessionrestore_no_auto_restore']}, 17:04:04 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:04:04 INFO - 'tests': ['a11yr', 17:04:04 INFO - 'ts_paint', 17:04:04 INFO - 'tpaint', 17:04:04 INFO - 'sessionrestore', 17:04:04 INFO - 'sessionrestore_no_auto_restore']}, 17:04:04 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:04:04 INFO - 'tests': ['a11yr', 17:04:04 INFO - 'ts_paint', 17:04:04 INFO - 'tpaint', 17:04:04 INFO - 'sessionrestore', 17:04:04 INFO - 'sessionrestore_no_auto_restore']}, 17:04:04 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:04:04 INFO - 'tests': ['a11yr', 17:04:04 INFO - 'ts_paint', 17:04:04 INFO - 'tpaint', 17:04:04 INFO - 'sessionrestore', 17:04:04 INFO - 'sessionrestore_no_auto_restore']}, 17:04:04 INFO - 'other_l64': {'tests': ['a11yr', 17:04:04 INFO - 'ts_paint', 17:04:04 INFO - 'tpaint', 17:04:04 INFO - 'sessionrestore', 17:04:04 INFO - 'sessionrestore_no_auto_restore']}, 17:04:04 INFO - 'other_nol64': {'tests': ['a11yr', 17:04:04 INFO - 'ts_paint', 17:04:04 INFO - 'tpaint', 17:04:04 INFO - 'sessionrestore', 17:04:04 INFO - 'sessionrestore_no_auto_restore']}, 17:04:04 INFO - 'svgr': {'tests': ['tsvgx', 17:04:04 INFO - 'tsvgr_opacity', 17:04:04 INFO - 'tart', 17:04:04 INFO - 'tscrollx', 17:04:04 INFO - 'cart']}, 17:04:04 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:04:04 INFO - 'tests': ['tsvgx', 17:04:04 INFO - 'tsvgr_opacity', 17:04:04 INFO - 'tart', 17:04:04 INFO - 'tscrollx', 17:04:04 INFO - 'cart']}, 17:04:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:04:04 INFO - 'tests': ['tp5o']}, 17:04:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:04:04 INFO - 'talos_options': ['--e10s'], 17:04:04 INFO - 'tests': ['tp5o']}, 17:04:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:04:04 INFO - 'talos_options': ['--xperf_path', 17:04:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:04:04 INFO - 'tests': ['tp5n']}, 17:04:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:04:04 INFO - 'talos_options': ['--e10s', 17:04:04 INFO - '--xperf_path', 17:04:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:04:04 INFO - 'tests': ['tp5n']}}, 17:04:04 INFO - 'talos.zip': {'path': '', 17:04:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:04:04 INFO - Running post-action listener: _resource_record_post_action 17:04:04 INFO - ##### 17:04:04 INFO - ##### Running create-virtualenv step. 17:04:04 INFO - ##### 17:04:04 INFO - Running pre-action listener: _resource_record_pre_action 17:04:04 INFO - Running main action method: create_virtualenv 17:04:04 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 17:04:04 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 17:04:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 17:04:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:04:04 INFO - Using real prefix '/usr' 17:04:04 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 17:04:05 INFO - Installing distribute.............................................................................................................................................................................................done. 17:04:07 INFO - Installing pip.................done. 17:04:07 INFO - Return code: 0 17:04:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 17:04: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')]} 17:04:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04: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')]} 17:04:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcfdf54df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dcf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f30840>, '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 0x1e9d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9db60>, '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': 'e25b24362c3bb3dea6e300e4000001c1-1450831259.767204-550062830', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:04: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', 'pip>=1.5'] in /builds/slave/test-pgo/build 17:04: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 pip>=1.5 17:04:07 INFO - Using env: {'DISPLAY': ':0', 17:04:07 INFO - 'HOME': '/home/cltbld', 17:04:07 INFO - 'LANG': 'en_US.UTF-8', 17:04:07 INFO - 'LANGUAGE': 'en_US:en', 17:04:07 INFO - 'LOGNAME': 'cltbld', 17:04:07 INFO - 'MAIL': '/var/mail/cltbld', 17:04:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:07 INFO - 'MOZ_NO_REMOTE': '1', 17:04:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:07 INFO - 'NO_EM_RESTART': '1', 17:04:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:04:07 INFO - 'PWD': '/builds/slave/test-pgo', 17:04:07 INFO - 'SHELL': '/bin/bash', 17:04:07 INFO - 'SHLVL': '1', 17:04:07 INFO - 'TERM': 'linux', 17:04:07 INFO - 'TMOUT': '86400', 17:04:07 INFO - 'USER': 'cltbld', 17:04:07 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1450831259.767204-550062830', 17:04:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:07 INFO - '_': '/tools/buildbot/bin/python'} 17:04:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:07 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 17:04:07 INFO - Cleaning up... 17:04:07 INFO - Return code: 0 17:04:07 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 17:04: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')]} 17:04:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04: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')]} 17:04:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04: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', '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 0x7fcfdf54df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dcf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f30840>, '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 0x1e9d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9db60>, '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': 'e25b24362c3bb3dea6e300e4000001c1-1450831259.767204-550062830', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:04: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', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 17:04: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 psutil>=0.7.1 17:04:07 INFO - Using env: {'DISPLAY': ':0', 17:04:07 INFO - 'HOME': '/home/cltbld', 17:04:07 INFO - 'LANG': 'en_US.UTF-8', 17:04:07 INFO - 'LANGUAGE': 'en_US:en', 17:04:07 INFO - 'LOGNAME': 'cltbld', 17:04:07 INFO - 'MAIL': '/var/mail/cltbld', 17:04:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:07 INFO - 'MOZ_NO_REMOTE': '1', 17:04:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:07 INFO - 'NO_EM_RESTART': '1', 17:04:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:04:07 INFO - 'PWD': '/builds/slave/test-pgo', 17:04:07 INFO - 'SHELL': '/bin/bash', 17:04:07 INFO - 'SHLVL': '1', 17:04:07 INFO - 'TERM': 'linux', 17:04:07 INFO - 'TMOUT': '86400', 17:04:07 INFO - 'USER': 'cltbld', 17:04:07 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1450831259.767204-550062830', 17:04:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:07 INFO - '_': '/tools/buildbot/bin/python'} 17:04:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:07 INFO - Downloading/unpacking psutil>=0.7.1 17:04: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 17:04: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 17:04: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 17:04: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 17:04: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 17:04: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 17:04:09 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 17:04:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 17:04:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 17:04:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:04:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:04:09 INFO - Installing collected packages: psutil 17:04:09 INFO - Running setup.py install for psutil 17:04:09 INFO - building 'psutil._psutil_linux' extension 17:04:09 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 17:04:09 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 17:04:09 INFO - building 'psutil._psutil_posix' extension 17:04:09 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 17:04:09 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 17:04:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:04:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:04:09 INFO - Successfully installed psutil 17:04:09 INFO - Cleaning up... 17:04:09 INFO - Return code: 0 17:04:09 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 17:04:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:09 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7fcfdf54df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dcf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f30840>, '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 0x1e9d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9db60>, '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': 'e25b24362c3bb3dea6e300e4000001c1-1450831259.767204-550062830', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:04:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 17:04:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 17:04:09 INFO - Using env: {'DISPLAY': ':0', 17:04:09 INFO - 'HOME': '/home/cltbld', 17:04:09 INFO - 'LANG': 'en_US.UTF-8', 17:04:09 INFO - 'LANGUAGE': 'en_US:en', 17:04:09 INFO - 'LOGNAME': 'cltbld', 17:04:09 INFO - 'MAIL': '/var/mail/cltbld', 17:04:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:09 INFO - 'MOZ_NO_REMOTE': '1', 17:04:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:09 INFO - 'NO_EM_RESTART': '1', 17:04:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:04:09 INFO - 'PWD': '/builds/slave/test-pgo', 17:04:09 INFO - 'SHELL': '/bin/bash', 17:04:09 INFO - 'SHLVL': '1', 17:04:09 INFO - 'TERM': 'linux', 17:04:09 INFO - 'TMOUT': '86400', 17:04:09 INFO - 'USER': 'cltbld', 17:04:09 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1450831259.767204-550062830', 17:04:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:09 INFO - '_': '/tools/buildbot/bin/python'} 17:04:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:10 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:04:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:11 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:04:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 17:04:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:04:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:04:11 INFO - Installing collected packages: mozsystemmonitor 17:04:11 INFO - Running setup.py install for mozsystemmonitor 17:04:11 INFO - Successfully installed mozsystemmonitor 17:04:11 INFO - Cleaning up... 17:04:11 INFO - Return code: 0 17:04:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 17:04:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:11 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 0x7fcfdf54df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dcf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f30840>, '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 0x1e9d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9db60>, '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': 'e25b24362c3bb3dea6e300e4000001c1-1450831259.767204-550062830', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:04:11 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 17:04:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:04:11 INFO - Using env: {'DISPLAY': ':0', 17:04:11 INFO - 'HOME': '/home/cltbld', 17:04:11 INFO - 'LANG': 'en_US.UTF-8', 17:04:11 INFO - 'LANGUAGE': 'en_US:en', 17:04:11 INFO - 'LOGNAME': 'cltbld', 17:04:11 INFO - 'MAIL': '/var/mail/cltbld', 17:04:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:11 INFO - 'MOZ_NO_REMOTE': '1', 17:04:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:11 INFO - 'NO_EM_RESTART': '1', 17:04:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:04:11 INFO - 'PWD': '/builds/slave/test-pgo', 17:04:11 INFO - 'SHELL': '/bin/bash', 17:04:11 INFO - 'SHLVL': '1', 17:04:11 INFO - 'TERM': 'linux', 17:04:11 INFO - 'TMOUT': '86400', 17:04:11 INFO - 'USER': 'cltbld', 17:04:11 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1450831259.767204-550062830', 17:04:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:11 INFO - '_': '/tools/buildbot/bin/python'} 17:04:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:12 INFO - Downloading/unpacking blobuploader==1.2.4 17:04:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:13 INFO - Downloading blobuploader-1.2.4.tar.gz 17:04:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 17:04:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:04:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:04:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 17:04:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 17:04:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:04:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:14 INFO - Downloading docopt-0.6.1.tar.gz 17:04:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 17:04:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 17:04:14 INFO - Installing collected packages: blobuploader, requests, docopt 17:04:14 INFO - Running setup.py install for blobuploader 17:04:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:04:14 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 17:04:14 INFO - Running setup.py install for requests 17:04:14 INFO - Running setup.py install for docopt 17:04:15 INFO - Successfully installed blobuploader requests docopt 17:04:15 INFO - Cleaning up... 17:04:15 INFO - Return code: 0 17:04:15 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:04:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:15 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 0x7fcfdf54df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dcf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f30840>, '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 0x1e9d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9db60>, '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': 'e25b24362c3bb3dea6e300e4000001c1-1450831259.767204-550062830', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:04:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 17:04:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:04:15 INFO - Using env: {'DISPLAY': ':0', 17:04:15 INFO - 'HOME': '/home/cltbld', 17:04:15 INFO - 'LANG': 'en_US.UTF-8', 17:04:15 INFO - 'LANGUAGE': 'en_US:en', 17:04:15 INFO - 'LOGNAME': 'cltbld', 17:04:15 INFO - 'MAIL': '/var/mail/cltbld', 17:04:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:15 INFO - 'MOZ_NO_REMOTE': '1', 17:04:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:15 INFO - 'NO_EM_RESTART': '1', 17:04:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:04:15 INFO - 'PWD': '/builds/slave/test-pgo', 17:04:15 INFO - 'SHELL': '/bin/bash', 17:04:15 INFO - 'SHLVL': '1', 17:04:15 INFO - 'TERM': 'linux', 17:04:15 INFO - 'TMOUT': '86400', 17:04:15 INFO - 'USER': 'cltbld', 17:04:15 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1450831259.767204-550062830', 17:04:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:15 INFO - '_': '/tools/buildbot/bin/python'} 17:04:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:04:15 INFO - Running setup.py (path:/tmp/pip-YOqznj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:04:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:04:15 INFO - Running setup.py (path:/tmp/pip-mgZghl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:04:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:04:15 INFO - Running setup.py (path:/tmp/pip-3vK3W0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:04:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:04:15 INFO - Running setup.py (path:/tmp/pip-wD_1a_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:04:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 17:04:15 INFO - Running setup.py (path:/tmp/pip-LQJSNs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 17:04:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:04:15 INFO - Running setup.py (path:/tmp/pip-heB_AF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:04:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:04:15 INFO - Running setup.py (path:/tmp/pip-xJIeE3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:04:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:04:15 INFO - Running setup.py (path:/tmp/pip-1bNqmV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:04:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 17:04:15 INFO - Running setup.py (path:/tmp/pip-AHwUZg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 17:04:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 17:04:16 INFO - Running setup.py (path:/tmp/pip-hJvVwW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 17:04:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:04:16 INFO - Running setup.py (path:/tmp/pip-Oz4t6D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:04:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:04:16 INFO - Running setup.py (path:/tmp/pip-kBjSX_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:04:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:04:16 INFO - Running setup.py (path:/tmp/pip-9cn3K9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:04:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:04:16 INFO - Running setup.py (path:/tmp/pip-43RTfq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:04:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:04:16 INFO - Running setup.py (path:/tmp/pip-gLDeVM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:04:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 17:04:16 INFO - Running setup.py (path:/tmp/pip-QL1hn9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 17:04:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 17:04:16 INFO - Running setup.py (path:/tmp/pip-Dr1R2b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 17:04:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:04:16 INFO - Running setup.py install for manifestparser 17:04:16 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 17:04:16 INFO - Running setup.py install for mozcrash 17:04:16 INFO - Running setup.py install for mozdebug 17:04:16 INFO - Running setup.py install for mozdevice 17:04:16 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 17:04:16 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 17:04:16 INFO - Running setup.py install for mozfile 17:04:17 INFO - Running setup.py install for mozhttpd 17:04:17 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 17:04:17 INFO - Running setup.py install for mozinfo 17:04:17 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 17:04:17 INFO - Running setup.py install for mozInstall 17:04:17 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 17:04:17 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 17:04:17 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 17:04:17 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 17:04:17 INFO - Running setup.py install for mozleak 17:04:17 INFO - Running setup.py install for mozlog 17:04:17 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 17:04:17 INFO - Running setup.py install for moznetwork 17:04:17 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 17:04:17 INFO - Running setup.py install for mozprocess 17:04:17 INFO - Running setup.py install for mozprofile 17:04:17 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 17:04:17 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 17:04:17 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 17:04:17 INFO - Running setup.py install for mozrunner 17:04:18 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 17:04:18 INFO - Running setup.py install for mozscreenshot 17:04:18 INFO - Running setup.py install for moztest 17:04:18 INFO - Running setup.py install for mozversion 17:04:18 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 17:04:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:04:18 INFO - Cleaning up... 17:04:18 INFO - Return code: 0 17:04:18 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:04:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04: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', '-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 0x7fcfdf54df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dcf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f30840>, '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 0x1e9d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9db60>, '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': 'e25b24362c3bb3dea6e300e4000001c1-1450831259.767204-550062830', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:04:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 17:04:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:04:18 INFO - Using env: {'DISPLAY': ':0', 17:04:18 INFO - 'HOME': '/home/cltbld', 17:04:18 INFO - 'LANG': 'en_US.UTF-8', 17:04:18 INFO - 'LANGUAGE': 'en_US:en', 17:04:18 INFO - 'LOGNAME': 'cltbld', 17:04:18 INFO - 'MAIL': '/var/mail/cltbld', 17:04:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:18 INFO - 'MOZ_NO_REMOTE': '1', 17:04:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:18 INFO - 'NO_EM_RESTART': '1', 17:04:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:04:18 INFO - 'PWD': '/builds/slave/test-pgo', 17:04:18 INFO - 'SHELL': '/bin/bash', 17:04:18 INFO - 'SHLVL': '1', 17:04:18 INFO - 'TERM': 'linux', 17:04:18 INFO - 'TMOUT': '86400', 17:04:18 INFO - 'USER': 'cltbld', 17:04:18 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1450831259.767204-550062830', 17:04:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:18 INFO - '_': '/tools/buildbot/bin/python'} 17:04:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:04:18 INFO - Running setup.py (path:/tmp/pip-sbAAFo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:04:18 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 17:04:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:04:18 INFO - Running setup.py (path:/tmp/pip-DpYjFL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:04:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 17:04:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:04:18 INFO - Running setup.py (path:/tmp/pip-wp23q8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:04:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 17:04:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:04:18 INFO - Running setup.py (path:/tmp/pip-U5JA4q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:04:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 17:04:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 17:04:18 INFO - Running setup.py (path:/tmp/pip-8ZyAzd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 17:04:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 17:04:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:04:18 INFO - Running setup.py (path:/tmp/pip-0KB1z4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:04:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 17:04:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:04:19 INFO - Running setup.py (path:/tmp/pip-2F9EU_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:04:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 17:04:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:04:19 INFO - Running setup.py (path:/tmp/pip-wkUHWk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:04:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 17:04:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 17:04:19 INFO - Running setup.py (path:/tmp/pip-uuqf6a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 17:04:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 17:04:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 17:04:19 INFO - Running setup.py (path:/tmp/pip-EJaPst-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 17:04:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 17:04:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:04:19 INFO - Running setup.py (path:/tmp/pip-c0xiLz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:04:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 17:04:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:04:19 INFO - Running setup.py (path:/tmp/pip-o5m1Aa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:04:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 17:04:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:04:19 INFO - Running setup.py (path:/tmp/pip-YGgp2N-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:04:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 17:04:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:04:19 INFO - Running setup.py (path:/tmp/pip-CRZyF4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:04:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 17:04:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:04:19 INFO - Running setup.py (path:/tmp/pip-5eaRdf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:04:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 17:04:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 17:04:19 INFO - Running setup.py (path:/tmp/pip-QbOdPx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 17:04:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 17:04:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 17:04:19 INFO - Running setup.py (path:/tmp/pip-exkUn6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 17:04:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 17:04:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 17:04:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 17:04:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 17:04:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 17:04:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 17:04:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 17:04:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:21 INFO - Downloading blessings-1.5.1.tar.gz 17:04:21 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 17:04:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 17:04:21 INFO - Installing collected packages: blessings 17:04:21 INFO - Running setup.py install for blessings 17:04:21 INFO - Successfully installed blessings 17:04:21 INFO - Cleaning up... 17:04:21 INFO - Return code: 0 17:04:21 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 17:04:21 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 17:04:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 17:04:21 INFO - Reading from file tmpfile_stdout 17:04:21 INFO - Current package versions: 17:04:21 INFO - argparse == 1.2.1 17:04:21 INFO - blessings == 1.5.1 17:04:21 INFO - blobuploader == 1.2.4 17:04:21 INFO - docopt == 0.6.1 17:04:21 INFO - manifestparser == 1.1 17:04:21 INFO - mozInstall == 1.12 17:04:21 INFO - mozcrash == 0.16 17:04:21 INFO - mozdebug == 0.1 17:04:21 INFO - mozdevice == 0.47 17:04:21 INFO - mozfile == 1.2 17:04:21 INFO - mozhttpd == 0.7 17:04:21 INFO - mozinfo == 0.9 17:04:21 INFO - mozleak == 0.1 17:04:21 INFO - mozlog == 3.1 17:04:21 INFO - moznetwork == 0.27 17:04:21 INFO - mozprocess == 0.22 17:04:21 INFO - mozprofile == 0.28 17:04:21 INFO - mozrunner == 6.11 17:04:21 INFO - mozscreenshot == 0.1 17:04:21 INFO - mozsystemmonitor == 0.0 17:04:21 INFO - moztest == 0.7 17:04:21 INFO - mozversion == 1.4 17:04:21 INFO - psutil == 3.1.1 17:04:21 INFO - requests == 1.2.3 17:04:21 INFO - wsgiref == 0.1.2 17:04:21 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:04:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:21 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 0x7fcfdf54df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dcf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f30840>, '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 0x1e9d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9db60>, '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': 'e25b24362c3bb3dea6e300e4000001c1-1450831259.767204-550062830', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:04:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 17:04:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:04:21 INFO - Using env: {'DISPLAY': ':0', 17:04:21 INFO - 'HOME': '/home/cltbld', 17:04:21 INFO - 'LANG': 'en_US.UTF-8', 17:04:21 INFO - 'LANGUAGE': 'en_US:en', 17:04:21 INFO - 'LOGNAME': 'cltbld', 17:04:21 INFO - 'MAIL': '/var/mail/cltbld', 17:04:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:21 INFO - 'MOZ_NO_REMOTE': '1', 17:04:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:21 INFO - 'NO_EM_RESTART': '1', 17:04:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:04:21 INFO - 'PWD': '/builds/slave/test-pgo', 17:04:21 INFO - 'SHELL': '/bin/bash', 17:04:21 INFO - 'SHLVL': '1', 17:04:21 INFO - 'TERM': 'linux', 17:04:21 INFO - 'TMOUT': '86400', 17:04:21 INFO - 'USER': 'cltbld', 17:04:21 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1450831259.767204-550062830', 17:04:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:21 INFO - '_': '/tools/buildbot/bin/python'} 17:04:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 17:04:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 17:04:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 17:04:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 17:04:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 17:04:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 17:04:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 17:04:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 17:04:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 17:04:22 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 17:04:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 17:04:22 INFO - Cleaning up... 17:04:22 INFO - Return code: 0 17:04:22 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 17:04:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:22 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 0x7fcfdf54df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dcf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f30840>, '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 0x1e9d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9db60>, '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': 'e25b24362c3bb3dea6e300e4000001c1-1450831259.767204-550062830', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:04:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 17:04:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:04:22 INFO - Using env: {'DISPLAY': ':0', 17:04:22 INFO - 'HOME': '/home/cltbld', 17:04:22 INFO - 'LANG': 'en_US.UTF-8', 17:04:22 INFO - 'LANGUAGE': 'en_US:en', 17:04:22 INFO - 'LOGNAME': 'cltbld', 17:04:22 INFO - 'MAIL': '/var/mail/cltbld', 17:04:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:22 INFO - 'MOZ_NO_REMOTE': '1', 17:04:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:22 INFO - 'NO_EM_RESTART': '1', 17:04:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:04:22 INFO - 'PWD': '/builds/slave/test-pgo', 17:04:22 INFO - 'SHELL': '/bin/bash', 17:04:22 INFO - 'SHLVL': '1', 17:04:22 INFO - 'TERM': 'linux', 17:04:22 INFO - 'TMOUT': '86400', 17:04:22 INFO - 'USER': 'cltbld', 17:04:22 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1450831259.767204-550062830', 17:04:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:22 INFO - '_': '/tools/buildbot/bin/python'} 17:04:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:22 INFO - Downloading/unpacking jsonschema 17:04: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 17:04: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 17:04: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 17:04: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 17:04: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 17:04: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 17:04:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:04:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 17:04:24 INFO - Downloading/unpacking functools32 (from jsonschema) 17:04:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:24 INFO - Downloading functools32-3.2.3-2.tar.gz 17:04:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 17:04:24 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 17:04:24 INFO - warning: no files found matching '*.txt' 17:04:24 INFO - no previously-included directories found matching 'build' 17:04:24 INFO - no previously-included directories found matching 'dist' 17:04:24 INFO - no previously-included directories found matching '.git*' 17:04:24 INFO - Installing collected packages: jsonschema, functools32 17:04:24 INFO - Running setup.py install for functools32 17:04:24 INFO - warning: no files found matching '*.txt' 17:04:24 INFO - no previously-included directories found matching 'build' 17:04:24 INFO - no previously-included directories found matching 'dist' 17:04:24 INFO - no previously-included directories found matching '.git*' 17:04:24 INFO - Successfully installed jsonschema functools32 17:04:24 INFO - Cleaning up... 17:04:24 INFO - Return code: 0 17:04:24 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 17:04:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:24 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 0x7fcfdf54df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dcf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f30840>, '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 0x1e9d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9db60>, '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': 'e25b24362c3bb3dea6e300e4000001c1-1450831259.767204-550062830', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:04:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 17:04:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 17:04:24 INFO - Using env: {'DISPLAY': ':0', 17:04:24 INFO - 'HOME': '/home/cltbld', 17:04:24 INFO - 'LANG': 'en_US.UTF-8', 17:04:24 INFO - 'LANGUAGE': 'en_US:en', 17:04:24 INFO - 'LOGNAME': 'cltbld', 17:04:24 INFO - 'MAIL': '/var/mail/cltbld', 17:04:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:24 INFO - 'MOZ_NO_REMOTE': '1', 17:04:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:24 INFO - 'NO_EM_RESTART': '1', 17:04:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:04:24 INFO - 'PWD': '/builds/slave/test-pgo', 17:04:24 INFO - 'SHELL': '/bin/bash', 17:04:24 INFO - 'SHLVL': '1', 17:04:24 INFO - 'TERM': 'linux', 17:04:24 INFO - 'TMOUT': '86400', 17:04:24 INFO - 'USER': 'cltbld', 17:04:24 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1450831259.767204-550062830', 17:04:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:24 INFO - '_': '/tools/buildbot/bin/python'} 17:04:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:24 INFO - Downloading/unpacking flake8 17:04:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:26 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:04:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 17:04:26 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:04:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:26 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:04:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 17:04:26 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:04:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 17:04:26 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:04:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 17:04:26 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 17:04:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:04:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:04:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:04:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:04:27 INFO - no previously-included directories found matching 'docs/_build' 17:04:27 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:04:27 INFO - Running setup.py install for pep8 17:04:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:04:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:04:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:04:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:04:27 INFO - no previously-included directories found matching 'docs/_build' 17:04:27 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 17:04:27 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:04:27 INFO - Cleaning up... 17:04:27 INFO - Return code: 0 17:04:27 INFO - Running post-action listener: _resource_record_post_action 17:04:27 INFO - Running post-action listener: _start_resource_monitoring 17:04:27 INFO - Starting resource monitoring. 17:04:27 INFO - ##### 17:04:27 INFO - ##### Running install step. 17:04:27 INFO - ##### 17:04:27 INFO - Running pre-action listener: _resource_record_pre_action 17:04:27 INFO - Running main action method: install 17:04:27 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 17:04:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 17:04:27 INFO - Reading from file tmpfile_stdout 17:04:27 INFO - Detecting whether we're running mozinstall >=1.0... 17:04:27 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 17:04:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 17:04:27 INFO - Reading from file tmpfile_stdout 17:04:27 INFO - Output received: 17:04:27 INFO - Usage: mozinstall [options] installer 17:04:27 INFO - Options: 17:04:27 INFO - -h, --help show this help message and exit 17:04:27 INFO - -d DEST, --destination=DEST 17:04:27 INFO - Directory to install application into. [default: 17:04:27 INFO - "/builds/slave/test-pgo"] 17:04:27 INFO - --app=APP Application being installed. [default: firefox] 17:04:27 INFO - mkdir: /builds/slave/test-pgo/build/application 17:04:27 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 17:04:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 17:04:43 INFO - Reading from file tmpfile_stdout 17:04:43 INFO - Output received: 17:04:43 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 17:04:43 INFO - Running post-action listener: _resource_record_post_action 17:04:43 INFO - ##### 17:04:43 INFO - ##### Running run-tests step. 17:04:43 INFO - ##### 17:04:43 INFO - Running pre-action listener: _resource_record_pre_action 17:04:43 INFO - Running main action method: run_tests 17:04:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 17:04:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 17:04:43 INFO - Python 2.7.3 17:04:43 INFO - Return code: 0 17:04:43 INFO - grabbing minidump binary from tooltool 17:04:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:43 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 0x1f30840>, '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 0x1e9d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9db60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 17:04:43 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 17:04:43 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 17:04:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:04:43 INFO - Return code: 0 17:04:43 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 17:04:43 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 17:04:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 17:04:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 17:04:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 17:04:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 17:04:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 17:04:44 INFO - Return code: 0 17:04:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JDjODWhqTOqY6mOmBWxxMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 17:04:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JDjODWhqTOqY6mOmBWxxMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-058 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 17:04:44 INFO - Using env: {'DISPLAY': ':0', 17:04:44 INFO - 'HOME': '/home/cltbld', 17:04:44 INFO - 'LANG': 'en_US.UTF-8', 17:04:44 INFO - 'LANGUAGE': 'en_US:en', 17:04:44 INFO - 'LOGNAME': 'cltbld', 17:04:44 INFO - 'MAIL': '/var/mail/cltbld', 17:04:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 17:04:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 17:04:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:44 INFO - 'MOZ_NO_REMOTE': '1', 17:04:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 17:04:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:44 INFO - 'NO_EM_RESTART': '1', 17:04:44 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:04:44 INFO - 'PWD': '/builds/slave/test-pgo', 17:04:44 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 17:04:44 INFO - 'SHELL': '/bin/bash', 17:04:44 INFO - 'SHLVL': '1', 17:04:44 INFO - 'TERM': 'linux', 17:04:44 INFO - 'TMOUT': '86400', 17:04:44 INFO - 'USER': 'cltbld', 17:04:44 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1450831259.767204-550062830', 17:04:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:44 INFO - '_': '/tools/buildbot/bin/python'} 17:04:44 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JDjODWhqTOqY6mOmBWxxMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 17:04:44 INFO - mozversion application_buildid: 20151222143005 17:04:44 INFO - mozversion application_changeset: 645cb0f2d2836e5daddff06665bbd306a8b9093d 17:04:44 INFO - mozversion application_display_name: Nightly 17:04:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:04:44 INFO - mozversion application_name: Firefox 17:04:44 INFO - mozversion application_remotingname: firefox 17:04:44 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:04:44 INFO - mozversion application_vendor: Mozilla 17:04:44 INFO - mozversion application_version: 46.0a1 17:04:44 INFO - mozversion platform_buildid: 20151222143005 17:04:44 INFO - mozversion platform_changeset: 645cb0f2d2836e5daddff06665bbd306a8b9093d 17:04:44 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:04:44 INFO - mozversion platform_version: 46.0a1 17:04:44 INFO - using testdate: 1450832684 17:04:44 INFO - actual date: 1450832684 17:04:44 INFO - starting webserver on 'localhost:45078' 17:04:44 INFO - SUITE-START | Running 3 tests 17:04:44 INFO - TEST-START | dromaeo_css 17:04:44 INFO - operating with platform_type : linux_ 17:04:44 INFO - Initialising browser for dromaeo_css test... 17:04:44 INFO - TEST-INFO | started process 14768 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpjgLFiQ/profile http://localhost:45078/getInfo.html) 17:04:48 INFO - PROCESS | 14768 | __metrics Screen width/height:1600/1200 17:04:48 INFO - PROCESS | 14768 | colorDepth:24 17:04:48 INFO - PROCESS | 14768 | Browser inner width/height: 1024/697 17:04:48 INFO - PROCESS | 14768 | __metrics 17:04:49 INFO - PROCESS | 14768 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:04:49 INFO - PROCESS | 14768 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:04:50 INFO - TEST-INFO | 14768: exit 0 17:04:50 INFO - Browser initialized. 17:04:50 INFO - Running cycle 1/1 for dromaeo_css test... 17:04:50 INFO - TEST-INFO | started process 14862 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpjgLFiQ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:05:01 INFO - PROCESS | 14862 | RSS: Main: 149929984 17:05:01 INFO - PROCESS | 14862 | 17:05:53 INFO - PROCESS | 14862 | 1450832753480 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 17:08:01 INFO - PROCESS | 14862 | Cycle 1(1): loaded http://localhost:45078/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45078/tests/dromaeo/cssquery-ext.html) 17:08:03 INFO - PROCESS | 14862 | RSS: Main: 320876544 17:08:03 INFO - PROCESS | 14862 | 17:11:05 INFO - PROCESS | 14862 | Cycle 1(1): loaded http://localhost:45078/tests/dromaeo/cssquery-ext.html (next: http://localhost:45078/tests/dromaeo/cssquery-jquery.html) 17:11:06 INFO - PROCESS | 14862 | RSS: Main: 229732352 17:11:06 INFO - PROCESS | 14862 | 17:14:08 INFO - PROCESS | 14862 | Cycle 1(1): loaded http://localhost:45078/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45078/tests/dromaeo/cssquery-mootools.html) 17:14:08 INFO - PROCESS | 14862 | RSS: Main: 227143680 17:14:08 INFO - PROCESS | 14862 | 17:17:10 INFO - PROCESS | 14862 | Cycle 1(1): loaded http://localhost:45078/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45078/tests/dromaeo/cssquery-prototype.html) 17:17:11 INFO - PROCESS | 14862 | RSS: Main: 212615168 17:17:11 INFO - PROCESS | 14862 | 17:20:13 INFO - PROCESS | 14862 | Cycle 1(1): loaded http://localhost:45078/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45078/tests/dromaeo/cssquery-yui.html) 17:20:14 INFO - PROCESS | 14862 | RSS: Main: 215289856 17:20:14 INFO - PROCESS | 14862 | 17:23:17 INFO - PROCESS | 14862 | Cycle 1(1): loaded http://localhost:45078/tests/dromaeo/cssquery-yui.html (next: http://localhost:45078/tests/dromaeo/cssquery-dojo.html) 17:23:17 INFO - PROCESS | 14862 | RSS: Main: 300589056 17:23:17 INFO - PROCESS | 14862 | 17:23:17 INFO - PROCESS | 14862 | __start_tp_report 17:23:17 INFO - PROCESS | 14862 | _x_x_mozilla_page_load 17:23:17 INFO - PROCESS | 14862 | _x_x_mozilla_page_load_details 17:23:17 INFO - PROCESS | 14862 | |i|pagename|runs| 17:23:17 INFO - PROCESS | 14862 | |0;dojo.html;3081.8459077046145;3149.3543823516184;3193.409219294431;3199.632042315133;3219.356128774245;5099.133147364948;5183.792648294064;5271.894562108756;5312.987412948668;5372.543333816626;5129.0767661820855;5164.6384753067305;5192.247124166994;5222.981518603874;5254.343207099113;4785.712857228577;4847.975760121194;4851.854444366674;4886.902261954759;4948.925766113512;4878.512148785111;4888.462269150391;4904.190808516609;4933.506649335073;4958.305837182779;4625.514320996297;4736.83421080264;4739.336492890998;4803.2554953981835;4831.951680483186;4774.73738944358;4799.616030717534;4801.4718380978065;4808.663393562417;4844.103840789465;4751.477337492873;4769.785359658824;4789.80840766369;4799.688020278671;4846.9515304846855;4881.585065269456;4995.975020124913;5047.924281135786;5129.487051294878;5186.118359878829;5660.094384898438;5673.773049078032;5684.175794509814;5684.289463817023;5687.943120568824;5685.857853553653;5686.658800471985;5716.942830571683;5718.885622287531;5730.742116604721;5153.304303918961;5236.842894713165;5247.291615631917;5253.605979551511;5332.9466705333225;5781.971090144522;5785;5785.450382213683;5824.796132135355;5841.269841269841;5553.389127196006;5558.805441809598;5559.388467268597;5565.248691426606;5566.916496252559;5473;5511.53151982078;5566.944330556724;5594.384617692051;5701.429857014348;5601.159826026047;5621.8594535136945;5622.606417550732;5625.746841392147;5696.658200507983;5612.186232996192;5614.185943038318;5615.18579805934;5619.353774316006;5625.128105143709;4293.892652683646;4373.9343909840745;4374.300111982131;4377.496587892433;4406.691531592758;3896.7661940283674;3926.3521518949055;3946.723729338976;3960.0693836948294;3968.6428221460205;5315.176147697113;5321.866953326198;5325.174597937326;5332.92000619991;5334.11987022137;5632.915506267409;5653.095504719226;5658.377578466366;5664.971675141598;5711.371749107595;5197.974010129925;5260.263563101169;5276.314079169683;5305.628605997543;5313.8937221255355;4859.489753575895;4860.198067318853;4882.51174882516;4891.461939186686;4910.975445122752;5723.59934804568;5734;5741.311042674905;5742.655440673573;5750.7987220447085;5476.288082549243;5571.0807716726285;5575.968445837533;5686.60193786431;5693.174489699053;5639.689817060101;5675.68783716883;5676.602637815313;5691.857703557279;5746.482816546531;5501.642393244587;5548.611597188158;5558.110702287615;5559.58303127259;5561.582881284001;5456.727163641723;5547.7780888764;5552.361478429871;5568.1091025435735;5581.079121944996;5480.753366098615;5497.587680923867;5504.80733174337;5507.091329930517;5509.118541033576;5480.972595136999;5486.561075113901;5487.506124448819;5488.039593071277;5501.229827824188;5323.973380133075;5412.377576578744;5497.890042199214;5498.147787093007;5503.9174412383045;5520.7515661796115;5596.1605759136455;5601.887962240814;5606.803761868315;5627;5229.058769421388;5325.786968521215;5328.62699611039;5481.095619222783;5516.034693928466 17:23:17 INFO - PROCESS | 14862 | |1;ext.html;557.4136008918617;594.5629961977945;609.135028259871;615.9353267906872;621.1955517604704;27607.861960690192;38688.226235475275;38935;39358.60641393585;39379;42478.787606062004;42992.14015719692;43109.35335969963;43176.352354714705;43198.35202471966;7578.65896034677;7668.156502784689;8694.174053464927;8882.46705197687;9958.90041099587;10219.54012069455;10362.896371036268;10367.844482332772;10378.221633377489;10378.584856605727;10211.183105351554;10283.382997020166;10286.897131028707;10290.125339346127;10323.793524129513;7799.532028078305;7996.48022878514;10415.16678665705;10637;10658.147348212124;10040.29717919746;10112.089911907964;10146.391216526958;10167.949160254151;10177;39406.80296598528;39799.60200397988;39837.402438963436;39907;39909;3331.1006028372444;3460.446328587439;3466.6533346665383;3694.0949467380665;3795.2409518096492;29502.40995180106;29539.85230073836;29557;29665.703342966724;30000.399992000257;3848.6536211741077;3871.8838434846716;3955.149642826806;3978.6618137458063;4005.83976640934;276454;277693;278305;278733;278988;53448.73275633597;57163.14255286174;57208.42791572114;57766.133507997416;57797;50806.49193508018;66653.33346666569;67887;67912;67929.66035169792;15492.225388730518;15776.842231577537;15782.842171578366;15784.763228551581;15786.60533486649;11851.585194518151;11949.462274197682;11987.280763154238;11987.460564274628;11988.100892433102;18771.530711732317;18778.342758003404;18780.248790048245;18895.43313700591;19053.904730476257;7378.372838308804;7633.274838890296;7638.541687498657;7653.846923061507;7676.232376762391;934.243262957007;1035.5805898611075;1039.5114296280735;1096.7477480179602;1147.1951923268289;27843.860780695966;27926;28026.71973280282;28173.43653126926;28265.293367665974;1050.2333296693457;1073.2487258918788;1104.0394856474918;1114.6098865397046;1115.5330740076772;14388.784168237486;14503.347349369304;15467;16066.518004459886;16276.674466510603;457240;466541;467024;467540;469158;48847.5115248843;49098.263526047136;49179.754101229264;49324.75337623289;49449;1350.3450826349213;1356.8575299593401;1363.6181869076675;1393.0248825821966;1504.3456096597797;24194.63708044416;26978.32554186161;27851.860740696167;29384.95672509982;30168.5474717875;44084.779576101915;44287.778561106985;44457.33314000228;44633.55366446294;44752.77623611861;250070;254405;254423.55094020444;256797;257431;26254.212373628823;27391;27518.724812752418;27632.447351052466;30109.096727098222;35809.28381432305;37248.44127338038;37319.44020839635;41431.585684142774;42325.36511952385;31256.374872502878;31991.6800831998;32490.837545813065;32819.50770738393;32922;28757;33784.49323260202;35285;35596.28807423889;35780.28439431249;28834.567481487375;34370.484442733876;34435.65564344324;34448.483272750425;34494.82752586221;27708.445831082863;31191.84404077965;33631.76487492107;33676;33676.49485257772;25241.063553568954;25262.87368563219;25571.36071598225;25624.103156389436;25703.485930280916 17:23:17 INFO - PROCESS | 14862 | |2;jquery.html;358.7363287983332;360.60693843710357;362.18508356198555;365.86280144945647;366.6809875408395;13632.659183520416;13698.726025479484;16727.33090676373;16805.159742012896;17119.288071192874;12925.612231633066;15647.374105035813;15679.764803527956;15900.045997240173;16050.59873503163;5125.589952803767;5247.790088396459;5247.868803279929;5250.894982100355;5251.842444726664;3904.1606054698236;4012.5385580658162;5094.032133894567;5222.32109825724;5233.685978841263;5829.329627092875;5950.315713692938;5989.401059894019;6004.489618382443;6010;5686;5773.971130144364;5788.942110578882;5930.288365396137;5937.67342796146;5241.86895327616;5254.973725131388;5257.76340064698;5258.39528454225;5259.421463638997;19560.413187604394;19831.603367932705;20030.69953950692;20103.095360708805;20109;2211.159759291475;2280.749117597063;2343.7656234376595;2459.8155138364514;2534.1763926723706;12883.935580322039;12955.805662915063;13070.86929130706;13317.334133293394;13521.053526253167;1784.50925995351;1844.4558855137766;1887.782904965919;1904.0670071664922;1915.82757551821;55534;57702.422975770125;58701;58917.410825891624;59356;9573.138417542455;9887.851682224773;9926.553305101288;9967;10049.59801607942;12786.872131278567;12850.421731022127;12860.935695321463;12863.807042894365;12869.742605147845;7738.845223095506;7778.64996075178;7783.299503044753;7784.416168787364;7790.454668173287;7578.09062912454;7588.886166707503;7590.127135379392;7642.923570764332;7648.349890259279;5844.064949608127;5878.265911556101;5923.733431995571;5925.762969481259;5966.075258334965;1660.2777791660667;1700.5493544210794;1756.481837857835;1794.5414781748827;1805.4764118405778;394.93878448840474;401.34179944890406;426.96674048801975;989.9604015839286;1013.6046941692746;9455.479948602893;9692.321537492307;10014.49927503622;10026.69919902404;10089.596416143419;447.3468735645993;827.8840962265288;837.5728378526995;918.9540522973824;943.7970836270235;8864.64541418349;9270.629174832931;9754.073363030642;9817.214622830157;9822.557984890696;542368.2881585567;552962;559869;562317;565902;42830.357544636856;43022.35466468005;43177.35233971493;71192.18540662731;78949;1120.0983208517223;1142.994285028586;1151.9596814111467;1177.1112809828526;1193.200555627714;14705.41178352854;15439.84560154384;15671.294791734172;15762.561916138913;15890.205489725698;34819.65180348265;35442.8227858859;35589.28821423609;36311.455328170625;36529;46684.299735504675;47620.7618961903;48365.27452088292;48880.26679599738;50978.49021509737;9007.864882026906;9049.321300902327;9076.41003334781;9278.860817087614;9300.767480813034;10683.198760092868;10822.458877055959;10828.458577071273;15611.921940390226;17169;13510.392032358764;13720.588382348546;14451.349689264218;14531;14651.413943442569;8855.070217627057;8962.103789621247;9279.257659387098;13876.58370248894;13998.860011399756;9868.210543156674;9935.20518358515;10004.099631033241;10044.748881278027;10187.286889917634;13842.169469831439;14407.783883241551;14587.635309117357;15259.771103433679;15286.847131528542;15047.89319569192;15332.616684582974;15490.84509154939;15665.765013524579;16228.594285142966 17:23:17 INFO - PROCESS | 14862 | |3;mootools.html;1470.514730139054;1528.1289664891012;1581.2410043179273;1664.284357726178;1769.6372243690053;6410.423061924426;7432.851342973144;7584.7724568262975;7593.392528597713;7597.810054748634;7424.665890034948;7584.127825300092;7588.848223035536;7593.658285377158;7598.924010759891;1913.550315675815;1951.6877299632063;1953.4432686684297;2246.0454306919573;2291.8051965582945;1960.9313674021412;2233.3300009997015;2289.599320118981;2290.633498640218;2299.942501437469;2213.181122984498;2244.8091912187483;2252.5044490212126;2260.1750361118156;2262.875541845198;2209.8232141428725;2210.0165426385265;2222.7777222277805;2231.564844855254;2236.541508990653;2254.9774502255095;2275.4993901341677;2276.5105502316915;2277.089164334263;2278.4303924018996;7436.962815185943;7506.43701722373;7507.8498430031095;7511.173770885198;7516.173220945691;4538.115067561826;4610.469795973472;4619.145458090264;4619.5611416915335;4620.491745907947;2925.18094933419;2938.412317536501;2963.955540666892;2984.910452686423;2998;973.090160699748;1002.4085789384299;1032.7005168501125;1036.041661463151;1049.574922156528;10210.489475526194;10219.18246540275;10222.386656800616;10227.079562839306;10240.590376384936;4162.4796900387455;4186.476690413699;4230.069384735353;4237.597428244312;4261.957380426218;8824.647014119364;8830.779230519289;8835.293176545862;8835.64657413709;8848.380613357003;4518.983228773565;4524.411826462605;4543.341215523797;4554.43069616298;4566.269396896547;4101.26177288091;4138.896527586834;4144.026153853842;4145.17096580685;4149.294619914622;3144.119646498984;3185.4425475542153;3622.5109610202812;3643.5081264029545;3697.6672099510633;1152.7521582859727;1167.4921409186861;1169.8011338072547;1179.1392283632997;1179.292424545266;1067.3809190669392;1088.6570730220114;1088.9945550272198;1218.9512419503299;1322.4379638653534;7001.36987671112;7181.676824542908;7256.129264488295;7257.92742072583;7261;1094.3324572011068;1110.2783190925802;1123.0566324287638;1126.5268587193398;1147.0995268714018;5660.405657405995;5661.688607126647;5731.541476681856;5760.07838745807;5760.740766665426;8843.69047083349;8912.420692654956;9046.185843274005;9048.140426659456;9054.81890362189;8689.782755431164;8930.821383572293;9036.909630903738;9072.092790720875;9072.364934454525;7058.788236352918;7080.327368899946;7085.82285442868;7117.395021423237;7151;6874.759383421556;6918.930810691829;6939.306069393222;6972.860542789217;7008.824779380352;7701.152873184057;7929.286364227247;8029;8123.106458289702;8226.30076443509;8203.466774659628;8343.2908202801;8362;8405.495670259805;8446;6399.072134540373;6500.707468164039;6555.082288479522;6555.967220163869;6567.835804104936;6220.315765265726;6274.403931626488;6855.6572171390235;7267.672954717156;7278.745243916649;6777.6272305023695;6824.761133360308;6869.450443964371;6918.55029423106;6974.128233970754;6657.500687448558;6674.332566743481;6676.532642715158;6708.060871477899;6845.281245469353;6672.332766723289;6703.564268322543;6704.094947182068;6709.161354830646;6711.832204194934;6170.660613666112;6260.812175634738;6261.154744109669;6303.716332764945;6306.400891915261;6293.653849038347;6325.399087086719;6326.715297811517;6334.524910631629;6336.17629708135 17:23:17 INFO - PROCESS | 14862 | |4;prototype.html;335.48838022016423;339.76216648346156;341.8376271271147;342.77034386960736;349.71323514717943;5936.287645482543;5976.133460648209;5991.161237426763;5997.550183736221;6011.857747028062;5673.602847800656;5766.509846663039;5804.738786754596;5904.468597826195;5925.61483503572;4549.636029117679;4601.12578610063;4626.6298696104395;4631.212693842055;4643.257078867382;4606.976965115186;4621.976890115545;4623;4627.259638457847;4645.3264276679865;4348.456442944632;4421.712588681726;4500.864974050767;4607.585317321457;4608.608268297199;4576.656750743708;4597.54024597541;4598;4599.931001034987;4610.031893302394;4040.252553277653;4050.2709512287774;4054.4526488924207;4064.268431682296;4085.5710150434074;5640.717964101778;5650.802221922254;5660.009498337816;5663.773449062074;5679.630823996427;5181.145111056671;5305.946940530623;5320.388155362106;5353.678779273256;5356.276902618136;6310.179676642053;6315.5894866833505;6320.557560970734;6327.367263273682;6329.873402531924;4416.447944006999;4416.845410410652;4419.513853476115;4422.977885110586;4426.358178064195;6433.067205255258;6574.079628851917;6590.868182636368;6613.768518101843;6645.468362530986;4500.864974050718;4504.09918016398;4515.503294637587;4515.841945531956;4516.3902873112365;4570.4743954445;4574.862754117382;4575.22221222393;4576.107659006529;4577.427821522309;5263.473652634706;5273.525382715574;5285.762140703678;5287.867803304871;5289.761960711778;6225.937740622536;6326.841828954221;6350.650714210763;6358.491320694426;6358.713857876407;1584.3504163292994;1614.4268784581539;1614.5640677017375;1614.741641337404;1614.765858950469;1073.9892601074046;1086.277625379114;1087.8531398261134;1102.7904698107334;1111.4053981120062;6131.478824299985;6133.049377346519;6134.141220229171;6136.570440069241;6139.4781443577795;6546.770863019867;6551.475881929434;6552.6068435894;6553.180852393451;6564.081028655992;5931.377205393372;5999.760009599567;6094.39056094387;6124.571280010446;6126.203593532901;3530.6292839252023;3550.680438760524;3565.322588708137;3566.0728210665416;3568.3041806847937;6658.4673226141795;6659.267480577133;6662.100616416818;6663.433608143362;6666.466682665375;6622.072909792633;6767.39093481589;6767.796966091025;6775.1531058617675;6775.796726098225;6659;6660.134182556237;6660.733570657119;6663.033860090357;6663.300353462817;6602.40578347951;6608.074869518367;6611;6614.107095542233;6621.039949207434;6381.8723625528155;6528.988006858945;6533.901991470037;6543.247526534319;6561;6638.734450621921;6642.302558231316;6647.933520664925;6648.468122550281;6676.866462670817;4554.271316589462;4555.840545580889;4557.453105627346;4558.726476411426;4558.954410455853;6439.903401448888;6556.311587283267;6613.834654133685;6623.900641490285;6639.070530125689;6410.61536307823;6419.582727122722;6422.518311126778;6423.068655044899;6430.7749228776765;6383.7765678202895;6420.582662126947;6427.132337134614;6436.259830119596;6442.130312407952;6179.505639548735;6289.339619340087;6321.146645202839;6321.336259692666;6338.809835704937;6454.709538070704;6456.9354306456335;6459.967700161469;6468.288488266193;6470.967645161744;6301.873962520815;6309;6312.526560508072;6312.873742525216;6319.747210111544 17:23:17 INFO - PROCESS | 14862 | |5;yui.html;759.8138456078258;786.5752493653425;812.2933048248024;831.5094094484253;859.1451505751774;13201.405936732846;13674.589762307134;13680.726385472284;13686.110402823835;13697.109687870281;12740.80888786669;12842.807357889638;12942.935285323583;13505.324733763322;13540.526081587146;664.6112024465693;667.6995352091554;804.5615139748836;825.0635528674937;825.1665817524314;801.7274126796888;818.8771684247381;824.2581676491146;824.575343697993;824.7195953375851;847.9194476524751;861.2894362151219;862.0216054777841;862.6376921692904;862.6980556805131;698.9091418115638;699.8915168148894;832.7585000349891;852.0754980845759;855.687673998989;615.8552740106071;623.8970569855968;625.5058503782006;625.6777759453839;625.974961001564;13778.035537512378;13938.512152074629;13945.930270348685;13946.790798138036;13952;12075.27548347102;12338.938305308506;12557.434915428828;12634.72276327753;12649.683757906034;10004.949975250078;10046.748831279276;10310.793784124275;10354.223433242538;10467.424291663956;3530.382183117944;3590.5870824854956;3614.963850361489;3615.5480564929385;3690.5940346561856;44758.10483790338;44802.77598611986;45295.77352113251;45303;45500.544994549964;9889.802203956024;9983.251256155672;9990.350627209207;10001.049900259464;10046.598136074475;17985;18212;18311.450656480327;18348;18358.449246522625;7077.858442831114;7168.175659799085;7247.23903990084;7389.261073892568;7492.887606685904;4108.342665173558;4147.875563733093;4197.916041679149;4205.074883525619;4300.892477688083;2977.389635124794;2988.491956367423;2993.9101826945225;2995.3859458810894;3006.2484378905274;563.8026690658237;564.7063526965954;571.5284889965795;574.3624576719837;594.3402822866615;574.4657468554201;596.3350863786847;598.5660396212711;611.4955161991375;611.6941529235382;8273.751787446387;8528.957355213184;8602.698905538402;8711.783098043768;8763.211310982042;516.3055690096813;549.8350494851528;571.3714913595012;627.8242092214188;661.3353579652419;3772.9245415091546;3806.2006978534264;3964.4647972523917;4105.137921036556;4176.665866730655;56609.7169514158;57058.71470642703;57197.71401142968;57264;57589;48540;49032;49395.259071113964;49528.257076143884;49701.50298496969;45423.31865022027;45513.317300240524;45816.312755308696;46012.76993615078;46055.078898421845;7993.360531157377;8091.514509129471;8115.567911040414;8136.145704701158;8361;32567.18582035468;32988;33154;33796.32407351888;34368.82815585906;39128.608713912494;39690.80154599324;40156;40360.59639403568;41113.38329924994;10521.894781052091;10556.313839600401;10613.9469302653;10683.732906677395;10832.837507437238;11154.442277885912;11431.599894004003;11487.13846461502;11487.94256028748;12030.27818330903;10952.835707464554;11059.889401106208;11294.265872718248;11301.434928253719;11400.258983166068;11207.383593902088;11432.07012758177;11501.597444089752;11660.825087623523;11794.938455539042;10733.731656708645;11076.778464430505;11563.479643415898;11566.595169169039;11574.363410012531;9837.852432213665;9970.40177589347;10231.63631859284;10297.74255643615;10506.579736810441;8965.865512017455;9005.95497022537;9169.862452063091;9431.528423578931;9447 17:23:17 INFO - PROCESS | 14862 | __end_tp_report 17:23:17 INFO - PROCESS | 14862 | __start_cc_report 17:23:17 INFO - PROCESS | 14862 | _x_x_mozilla_cycle_collect,1301 17:23:17 INFO - PROCESS | 14862 | __end_cc_report 17:23:17 INFO - PROCESS | 14862 | __startTimestamp1450833797306__endTimestamp 17:23:17 INFO - PROCESS | 14862 | 17:23:17 INFO - PROCESS | 14862 | ------- Summary: start ------- 17:23:17 INFO - PROCESS | 14862 | Number of tests: 6 17:23:17 INFO - PROCESS | 14862 | 17:23:17 INFO - PROCESS | 14862 | [#0] dojo.html Cycles:165 Average:5228.98 Median:5476.29 stddev:562.32 (10.3%) stddev-sans-first:538.23 17:23:17 INFO - PROCESS | 14862 | Values: 3081.8 3149.4 3193.4 3199.6 3219.4 5099.1 5183.8 5271.9 5313.0 5372.5 5129.1 5164.6 5192.2 5223.0 5254.3 4785.7 4848.0 4851.9 4886.9 4948.9 4878.5 4888.5 4904.2 4933.5 4958.3 4625.5 4736.8 4739.3 4803.3 4832.0 4774.7 4799.6 4801.5 4808.7 4844.1 4751.5 4769.8 4789.8 4799.7 4847.0 4881.6 4996.0 5047.9 5129.5 5186.1 5660.1 5673.8 5684.2 5684.3 5687.9 5685.9 5686.7 5716.9 5718.9 5730.7 5153.3 5236.8 5247.3 5253.6 5332.9 5782.0 5785.0 5785.5 5824.8 5841.3 5553.4 5558.8 5559.4 5565.2 5566.9 5473.0 5511.5 5566.9 5594.4 5701.4 5601.2 5621.9 5622.6 5625.7 5696.7 5612.2 5614.2 5615.2 5619.4 5625.1 4293.9 4373.9 4374.3 4377.5 4406.7 3896.8 3926.4 3946.7 3960.1 3968.6 5315.2 5321.9 5325.2 5332.9 5334.1 5632.9 5653.1 5658.4 5665.0 5711.4 5198.0 5260.3 5276.3 5305.6 5313.9 4859.5 4860.2 4882.5 4891.5 4911.0 5723.6 5734.0 5741.3 5742.7 5750.8 5476.3 5571.1 5576.0 5686.6 5693.2 5639.7 5675.7 5676.6 5691.9 5746.5 5501.6 5548.6 5558.1 5559.6 5561.6 5456.7 5547.8 5552.4 5568.1 5581.1 5480.8 5497.6 5504.8 5507.1 5509.1 5481.0 5486.6 5487.5 5488.0 5501.2 5324.0 5412.4 5497.9 5498.1 5503.9 5520.8 5596.2 5601.9 5606.8 5627.0 5229.1 5325.8 5328.6 5481.1 5516.0 17:23:17 INFO - PROCESS | 14862 | 17:23:17 INFO - PROCESS | 14862 | [#1] ext.html Cycles:180 Average:49196.76 Median:30680.20 stddev:91476.83 (298.2%) stddev-sans-first:91660.55 17:23:17 INFO - PROCESS | 14862 | Values: 557.4 594.6 609.1 615.9 621.2 27607.9 38688.2 38935.0 39358.6 39379.0 42478.8 42992.1 43109.4 43176.4 43198.4 7578.7 7668.2 8694.2 8882.5 9958.9 10219.5 10362.9 10367.8 10378.2 10378.6 10211.2 10283.4 10286.9 10290.1 10323.8 7799.5 7996.5 10415.2 10637.0 10658.1 10040.3 10112.1 10146.4 10167.9 10177.0 39406.8 39799.6 39837.4 39907.0 39909.0 3331.1 3460.4 3466.7 3694.1 3795.2 29502.4 29539.9 29557.0 29665.7 30000.4 3848.7 3871.9 3955.1 3978.7 4005.8 276454.0 277693.0 278305.0 278733.0 278988.0 53448.7 57163.1 57208.4 57766.1 57797.0 50806.5 66653.3 67887.0 67912.0 67929.7 15492.2 15776.8 15782.8 15784.8 15786.6 11851.6 11949.5 11987.3 11987.5 11988.1 18771.5 18778.3 18780.2 18895.4 19053.9 7378.4 7633.3 7638.5 7653.8 7676.2 934.2 1035.6 1039.5 1096.7 1147.2 27843.9 27926.0 28026.7 28173.4 28265.3 1050.2 1073.2 1104.0 1114.6 1115.5 14388.8 14503.3 15467.0 16066.5 16276.7 457240.0 466541.0 467024.0 467540.0 469158.0 48847.5 49098.3 49179.8 49324.8 49449.0 1350.3 1356.9 1363.6 1393.0 1504.3 24194.6 26978.3 27851.9 29385.0 30168.5 44084.8 44287.8 44457.3 44633.6 44752.8 250070.0 254405.0 254423.6 256797.0 257431.0 26254.2 27391.0 27518.7 27632.4 30109.1 35809.3 37248.4 37319.4 41431.6 42325.4 31256.4 31991.7 32490.8 32819.5 32922.0 28757.0 33784.5 35285.0 35596.3 35780.3 28834.6 34370.5 34435.7 34448.5 34494.8 27708.4 31191.8 33631.8 33676.0 33676.5 25241.1 25262.9 25571.4 25624.1 25703.5 17:23:17 INFO - PROCESS | 14862 | 17:23:17 INFO - PROCESS | 14862 | [#2] jquery.html Cycles:180 Average:28362.61 Median:2149.55 stddev:90711.20 (4220.0%) stddev-sans-first:90941.30 17:23:17 INFO - PROCESS | 14862 | Values: 358.7 360.6 362.2 365.9 366.7 13632.7 13698.7 16727.3 16805.2 17119.3 12925.6 15647.4 15679.8 15900.0 16050.6 5125.6 5247.8 5247.9 5250.9 5251.8 3904.2 4012.5 5094.0 5222.3 5233.7 5829.3 5950.3 5989.4 6004.5 6010.0 5686.0 5774.0 5788.9 5930.3 5937.7 5241.9 5255.0 5257.8 5258.4 5259.4 19560.4 19831.6 20030.7 20103.1 20109.0 2211.2 2280.7 2343.8 2459.8 2534.2 12883.9 12955.8 13070.9 13317.3 13521.1 1784.5 1844.5 1887.8 1904.1 1915.8 55534.0 57702.4 58701.0 58917.4 59356.0 9573.1 9887.9 9926.6 9967.0 10049.6 12786.9 12850.4 12860.9 12863.8 12869.7 7738.8 7778.6 7783.3 7784.4 7790.5 7578.1 7588.9 7590.1 7642.9 7648.3 5844.1 5878.3 5923.7 5925.8 5966.1 1660.3 1700.5 1756.5 1794.5 1805.5 394.9 401.3 427.0 990.0 1013.6 9455.5 9692.3 10014.5 10026.7 10089.6 447.3 827.9 837.6 919.0 943.8 8864.6 9270.6 9754.1 9817.2 9822.6 542368.3 552962.0 559869.0 562317.0 565902.0 42830.4 43022.4 43177.4 71192.2 78949.0 1120.1 1143.0 1152.0 1177.1 1193.2 14705.4 15439.8 15671.3 15762.6 15890.2 34819.7 35442.8 35589.3 36311.5 36529.0 46684.3 47620.8 48365.3 48880.3 50978.5 9007.9 9049.3 9076.4 9278.9 9300.8 10683.2 10822.5 10828.5 15611.9 17169.0 13510.4 13720.6 14451.3 14531.0 14651.4 8855.1 8962.1 9279.3 13876.6 13998.9 9868.2 9935.2 10004.1 10044.7 10187.3 13842.2 14407.8 14587.6 15259.8 15286.8 15047.9 15332.6 15490.8 15665.8 16228.6 17:23:17 INFO - PROCESS | 14862 | 17:23:17 INFO - PROCESS | 14862 | [#3] mootools.html Cycles:180 Average:5273.77 Median:6240.56 stddev:2698.79 (43.2%) stddev-sans-first:2691.22 17:23:17 INFO - PROCESS | 14862 | Values: 1470.5 1528.1 1581.2 1664.3 1769.6 6410.4 7432.9 7584.8 7593.4 7597.8 7424.7 7584.1 7588.8 7593.7 7598.9 1913.6 1951.7 1953.4 2246.0 2291.8 1960.9 2233.3 2289.6 2290.6 2299.9 2213.2 2244.8 2252.5 2260.2 2262.9 2209.8 2210.0 2222.8 2231.6 2236.5 2255.0 2275.5 2276.5 2277.1 2278.4 7437.0 7506.4 7507.8 7511.2 7516.2 4538.1 4610.5 4619.1 4619.6 4620.5 2925.2 2938.4 2964.0 2984.9 2998.0 973.1 1002.4 1032.7 1036.0 1049.6 10210.5 10219.2 10222.4 10227.1 10240.6 4162.5 4186.5 4230.1 4237.6 4262.0 8824.6 8830.8 8835.3 8835.6 8848.4 4519.0 4524.4 4543.3 4554.4 4566.3 4101.3 4138.9 4144.0 4145.2 4149.3 3144.1 3185.4 3622.5 3643.5 3697.7 1152.8 1167.5 1169.8 1179.1 1179.3 1067.4 1088.7 1089.0 1219.0 1322.4 7001.4 7181.7 7256.1 7257.9 7261.0 1094.3 1110.3 1123.1 1126.5 1147.1 5660.4 5661.7 5731.5 5760.1 5760.7 8843.7 8912.4 9046.2 9048.1 9054.8 8689.8 8930.8 9036.9 9072.1 9072.4 7058.8 7080.3 7085.8 7117.4 7151.0 6874.8 6918.9 6939.3 6972.9 7008.8 7701.2 7929.3 8029.0 8123.1 8226.3 8203.5 8343.3 8362.0 8405.5 8446.0 6399.1 6500.7 6555.1 6556.0 6567.8 6220.3 6274.4 6855.7 7267.7 7278.7 6777.6 6824.8 6869.5 6918.6 6974.1 6657.5 6674.3 6676.5 6708.1 6845.3 6672.3 6703.6 6704.1 6709.2 6711.8 6170.7 6260.8 6261.2 6303.7 6306.4 6293.7 6325.4 6326.7 6334.5 6336.2 17:23:17 INFO - PROCESS | 14862 | 17:23:17 INFO - PROCESS | 14862 | [#4] prototype.html Cycles:180 Average:5315.79 Median:6005.81 stddev:1592.43 (26.5%) stddev-sans-first:1552.40 17:23:17 INFO - PROCESS | 14862 | Values: 335.5 339.8 341.8 342.8 349.7 5936.3 5976.1 5991.2 5997.6 6011.9 5673.6 5766.5 5804.7 5904.5 5925.6 4549.6 4601.1 4626.6 4631.2 4643.3 4607.0 4622.0 4623.0 4627.3 4645.3 4348.5 4421.7 4500.9 4607.6 4608.6 4576.7 4597.5 4598.0 4599.9 4610.0 4040.3 4050.3 4054.5 4064.3 4085.6 5640.7 5650.8 5660.0 5663.8 5679.6 5181.1 5305.9 5320.4 5353.7 5356.3 6310.2 6315.6 6320.6 6327.4 6329.9 4416.4 4416.8 4419.5 4423.0 4426.4 6433.1 6574.1 6590.9 6613.8 6645.5 4500.9 4504.1 4515.5 4515.8 4516.4 4570.5 4574.9 4575.2 4576.1 4577.4 5263.5 5273.5 5285.8 5287.9 5289.8 6225.9 6326.8 6350.7 6358.5 6358.7 1584.4 1614.4 1614.6 1614.7 1614.8 1074.0 1086.3 1087.9 1102.8 1111.4 6131.5 6133.0 6134.1 6136.6 6139.5 6546.8 6551.5 6552.6 6553.2 6564.1 5931.4 5999.8 6094.4 6124.6 6126.2 3530.6 3550.7 3565.3 3566.1 3568.3 6658.5 6659.3 6662.1 6663.4 6666.5 6622.1 6767.4 6767.8 6775.2 6775.8 6659.0 6660.1 6660.7 6663.0 6663.3 6602.4 6608.1 6611.0 6614.1 6621.0 6381.9 6529.0 6533.9 6543.2 6561.0 6638.7 6642.3 6647.9 6648.5 6676.9 4554.3 4555.8 4557.5 4558.7 4559.0 6439.9 6556.3 6613.8 6623.9 6639.1 6410.6 6419.6 6422.5 6423.1 6430.8 6383.8 6420.6 6427.1 6436.3 6442.1 6179.5 6289.3 6321.1 6321.3 6338.8 6454.7 6456.9 6460.0 6468.3 6471.0 6301.9 6309.0 6312.5 6312.9 6319.7 17:23:17 INFO - PROCESS | 14862 | 17:23:17 INFO - PROCESS | 14862 | [#5] yui.html Cycles:180 Average:13416.44 Median:44780.44 stddev:15299.03 (34.2%) stddev-sans-first:15312.42 17:23:17 INFO - PROCESS | 14862 | Values: 759.8 786.6 812.3 831.5 859.1 13201.4 13674.6 13680.7 13686.1 13697.1 12740.8 12842.8 12942.9 13505.3 13540.5 664.6 667.7 804.6 825.1 825.2 801.7 818.9 824.3 824.6 824.7 847.9 861.3 862.0 862.6 862.7 698.9 699.9 832.8 852.1 855.7 615.9 623.9 625.5 625.7 626.0 13778.0 13938.5 13945.9 13946.8 13952.0 12075.3 12338.9 12557.4 12634.7 12649.7 10004.9 10046.7 10310.8 10354.2 10467.4 3530.4 3590.6 3615.0 3615.5 3690.6 44758.1 44802.8 45295.8 45303.0 45500.5 9889.8 9983.3 9990.4 10001.0 10046.6 17985.0 18212.0 18311.5 18348.0 18358.4 7077.9 7168.2 7247.2 7389.3 7492.9 4108.3 4147.9 4197.9 4205.1 4300.9 2977.4 2988.5 2993.9 2995.4 3006.2 563.8 564.7 571.5 574.4 594.3 574.5 596.3 598.6 611.5 611.7 8273.8 8529.0 8602.7 8711.8 8763.2 516.3 549.8 571.4 627.8 661.3 3772.9 3806.2 3964.5 4105.1 4176.7 56609.7 57058.7 57197.7 57264.0 57589.0 48540.0 49032.0 49395.3 49528.3 49701.5 45423.3 45513.3 45816.3 46012.8 46055.1 7993.4 8091.5 8115.6 8136.1 8361.0 32567.2 32988.0 33154.0 33796.3 34368.8 39128.6 39690.8 40156.0 40360.6 41113.4 10521.9 10556.3 10613.9 10683.7 10832.8 11154.4 11431.6 11487.1 11487.9 12030.3 10952.8 11059.9 11294.3 11301.4 11400.3 11207.4 11432.1 11501.6 11660.8 11794.9 10733.7 11076.8 11563.5 11566.6 11574.4 9837.9 9970.4 10231.6 10297.7 10506.6 8965.9 9006.0 9169.9 9431.5 9447.0 17:23:17 INFO - PROCESS | 14862 | -------- Summary: end -------- 17:23:17 INFO - PROCESS | 14862 | 17:23:18 INFO - TEST-INFO | 14862: exit 0 17:23:18 INFO - TEST-OK | dromaeo_css | took 1113266ms 17:23:18 INFO - TEST-START | kraken 17:23:18 INFO - operating with platform_type : linux_ 17:23:18 INFO - Initialising browser for kraken test... 17:23:18 INFO - TEST-INFO | started process 15053 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpeSIwv4/profile http://localhost:45078/getInfo.html) 17:23:22 INFO - PROCESS | 15053 | __metrics Screen width/height:1600/1200 17:23:22 INFO - PROCESS | 15053 | colorDepth:24 17:23:22 INFO - PROCESS | 15053 | Browser inner width/height: 1024/697 17:23:22 INFO - PROCESS | 15053 | __metrics 17:23:22 INFO - PROCESS | 15053 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:23:22 INFO - PROCESS | 15053 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:23:23 INFO - TEST-INFO | 15053: exit 0 17:23:23 INFO - Browser initialized. 17:23:23 INFO - Running cycle 1/1 for kraken test... 17:23:23 INFO - TEST-INFO | started process 15137 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpeSIwv4/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:23:35 INFO - PROCESS | 15137 | RSS: Main: 150687744 17:23:35 INFO - PROCESS | 15137 | 17:23:37 INFO - PROCESS | 15137 | Cycle 1(1): loaded http://localhost:45078/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45078/tests/kraken/driver.html?testName=audio-beat-detection) 17:23:38 INFO - PROCESS | 15137 | RSS: Main: 185888768 17:23:38 INFO - PROCESS | 15137 | 17:23:40 INFO - PROCESS | 15137 | Cycle 1(1): loaded http://localhost:45078/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45078/tests/kraken/driver.html?testName=audio-dft) 17:23:41 INFO - PROCESS | 15137 | RSS: Main: 176123904 17:23:41 INFO - PROCESS | 15137 | 17:23:44 INFO - PROCESS | 15137 | Cycle 1(1): loaded http://localhost:45078/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45078/tests/kraken/driver.html?testName=audio-fft) 17:23:44 INFO - PROCESS | 15137 | RSS: Main: 159424512 17:23:44 INFO - PROCESS | 15137 | 17:23:46 INFO - PROCESS | 15137 | Cycle 1(1): loaded http://localhost:45078/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45078/tests/kraken/driver.html?testName=audio-oscillator) 17:23:47 INFO - PROCESS | 15137 | RSS: Main: 163160064 17:23:47 INFO - PROCESS | 15137 | 17:23:49 INFO - PROCESS | 15137 | Cycle 1(1): loaded http://localhost:45078/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45078/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:23:50 INFO - PROCESS | 15137 | RSS: Main: 163549184 17:23:50 INFO - PROCESS | 15137 | 17:23:52 INFO - PROCESS | 15137 | Cycle 1(1): loaded http://localhost:45078/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45078/tests/kraken/driver.html?testName=imaging-darkroom) 17:23:53 INFO - PROCESS | 15137 | RSS: Main: 164814848 17:23:53 INFO - PROCESS | 15137 | 17:23:56 INFO - PROCESS | 15137 | Cycle 1(1): loaded http://localhost:45078/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45078/tests/kraken/driver.html?testName=imaging-desaturate) 17:23:57 INFO - PROCESS | 15137 | RSS: Main: 166055936 17:23:57 INFO - PROCESS | 15137 | 17:24:00 INFO - PROCESS | 15137 | Cycle 1(1): loaded http://localhost:45078/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45078/tests/kraken/driver.html?testName=json-parse-financial) 17:24:00 INFO - PROCESS | 15137 | RSS: Main: 165220352 17:24:00 INFO - PROCESS | 15137 | 17:24:02 INFO - PROCESS | 15137 | Cycle 1(1): loaded http://localhost:45078/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45078/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:24:02 INFO - PROCESS | 15137 | RSS: Main: 177246208 17:24:02 INFO - PROCESS | 15137 | 17:24:04 INFO - PROCESS | 15137 | Cycle 1(1): loaded http://localhost:45078/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45078/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:24:05 INFO - PROCESS | 15137 | RSS: Main: 173903872 17:24:05 INFO - PROCESS | 15137 | 17:24:07 INFO - PROCESS | 15137 | Cycle 1(1): loaded http://localhost:45078/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45078/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:24:07 INFO - PROCESS | 15137 | RSS: Main: 188809216 17:24:07 INFO - PROCESS | 15137 | 17:24:10 INFO - PROCESS | 15137 | Cycle 1(1): loaded http://localhost:45078/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45078/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:24:10 INFO - PROCESS | 15137 | RSS: Main: 194367488 17:24:10 INFO - PROCESS | 15137 | 17:24:13 INFO - PROCESS | 15137 | Cycle 1(1): loaded http://localhost:45078/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45078/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:24:13 INFO - PROCESS | 15137 | RSS: Main: 192937984 17:24:13 INFO - PROCESS | 15137 | 17:24:15 INFO - PROCESS | 15137 | Cycle 1(1): loaded http://localhost:45078/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45078/tests/kraken/driver.html?testName=ai-astar) 17:24:15 INFO - PROCESS | 15137 | RSS: Main: 252121088 17:24:15 INFO - PROCESS | 15137 | 17:24:15 INFO - PROCESS | 15137 | __start_tp_report 17:24:15 INFO - PROCESS | 15137 | _x_x_mozilla_page_load 17:24:15 INFO - PROCESS | 15137 | _x_x_mozilla_page_load_details 17:24:15 INFO - PROCESS | 15137 | |i|pagename|runs| 17:24:15 INFO - PROCESS | 15137 | |0;ai-astar;109;110;104;112;111;110;99;110;109;116 17:24:15 INFO - PROCESS | 15137 | |1;audio-beat-detection;148;123;152;162;126;145;151;126;167;122 17:24:15 INFO - PROCESS | 15137 | |2;audio-dft;161;161;159;160;160;160;161;167;162;163 17:24:15 INFO - PROCESS | 15137 | |3;audio-fft;71;71;81;96;72;71;73;111;88;73 17:24:15 INFO - PROCESS | 15137 | |4;audio-oscillator;93;102;141;93;92;92;136;94;92;134 17:24:15 INFO - PROCESS | 15137 | |5;imaging-gaussian-blur;110;109;109;110;109;109;110;110;110;109 17:24:15 INFO - PROCESS | 15137 | |6;imaging-darkroom;145;146;145;145;145;145;145;144;145;146 17:24:15 INFO - PROCESS | 15137 | |7;imaging-desaturate;95;96;96;96;95;95;96;96;96;95 17:24:15 INFO - PROCESS | 15137 | |8;json-parse-financial;59;60;60;58;57;58;59;66;57;56 17:24:15 INFO - PROCESS | 15137 | |9;json-stringify-tinderbox;66;66;67;67;67;66;66;68;67;68 17:24:15 INFO - PROCESS | 15137 | |10;stanford-crypto-aes;86;85;86;85;85;85;85;84;86;85 17:24:15 INFO - PROCESS | 15137 | |11;stanford-crypto-ccm;123;116;116;124;117;119;121;118;119;125 17:24:15 INFO - PROCESS | 15137 | |12;stanford-crypto-pbkdf2;140;156;153;153;154;141;153;149;150;141 17:24:15 INFO - PROCESS | 15137 | |13;stanford-crypto-sha256-iterative;68;66;67;66;67;67;66;67;67;69 17:24:15 INFO - PROCESS | 15137 | __end_tp_report 17:24:15 INFO - PROCESS | 15137 | __start_cc_report 17:24:15 INFO - PROCESS | 15137 | _x_x_mozilla_cycle_collect,943 17:24:15 INFO - PROCESS | 15137 | __end_cc_report 17:24:15 INFO - PROCESS | 15137 | __startTimestamp1450833855911__endTimestamp 17:24:15 INFO - PROCESS | 15137 | 17:24:15 INFO - PROCESS | 15137 | ------- Summary: start ------- 17:24:15 INFO - PROCESS | 15137 | Number of tests: 14 17:24:15 INFO - PROCESS | 15137 | 17:24:15 INFO - PROCESS | 15137 | [#0] ai-astar Cycles:10 Average:109.00 Median:110.50 stddev:4.59 (4.2%) stddev-sans-first:4.87 17:24:15 INFO - PROCESS | 15137 | Values: 109.0 110.0 104.0 112.0 111.0 110.0 99.0 110.0 109.0 116.0 17:24:15 INFO - PROCESS | 15137 | 17:24:15 INFO - PROCESS | 15137 | [#1] audio-beat-detection Cycles:10 Average:142.20 Median:149.50 stddev:16.75 (11.2%) stddev-sans-first:17.63 17:24:15 INFO - PROCESS | 15137 | Values: 148.0 123.0 152.0 162.0 126.0 145.0 151.0 126.0 167.0 122.0 17:24:15 INFO - PROCESS | 15137 | 17:24:15 INFO - PROCESS | 15137 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.00 stddev:2.27 (1.4%) stddev-sans-first:2.40 17:24:15 INFO - PROCESS | 15137 | Values: 161.0 161.0 159.0 160.0 160.0 160.0 161.0 167.0 162.0 163.0 17:24:15 INFO - PROCESS | 15137 | 17:24:15 INFO - PROCESS | 15137 | [#3] audio-fft Cycles:10 Average:80.70 Median:73.00 stddev:13.67 (18.7%) stddev-sans-first:14.04 17:24:15 INFO - PROCESS | 15137 | Values: 71.0 71.0 81.0 96.0 72.0 71.0 73.0 111.0 88.0 73.0 17:24:15 INFO - PROCESS | 15137 | 17:24:15 INFO - PROCESS | 15137 | [#4] audio-oscillator Cycles:10 Average:106.90 Median:92.00 stddev:21.05 (22.9%) stddev-sans-first:21.71 17:24:15 INFO - PROCESS | 15137 | Values: 93.0 102.0 141.0 93.0 92.0 92.0 136.0 94.0 92.0 134.0 17:24:15 INFO - PROCESS | 15137 | 17:24:15 INFO - PROCESS | 15137 | [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:110.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 17:24:15 INFO - PROCESS | 15137 | Values: 110.0 109.0 109.0 110.0 109.0 109.0 110.0 110.0 110.0 109.0 17:24:15 INFO - PROCESS | 15137 | 17:24:15 INFO - PROCESS | 15137 | [#6] imaging-darkroom Cycles:10 Average:145.10 Median:145.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 17:24:15 INFO - PROCESS | 15137 | Values: 145.0 146.0 145.0 145.0 145.0 145.0 145.0 144.0 145.0 146.0 17:24:15 INFO - PROCESS | 15137 | 17:24:15 INFO - PROCESS | 15137 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 17:24:15 INFO - PROCESS | 15137 | Values: 95.0 96.0 96.0 96.0 95.0 95.0 96.0 96.0 96.0 95.0 17:24:15 INFO - PROCESS | 15137 | 17:24:15 INFO - PROCESS | 15137 | [#8] json-parse-financial Cycles:10 Average:59.00 Median:59.00 stddev:2.79 (4.7%) stddev-sans-first:2.96 17:24:15 INFO - PROCESS | 15137 | Values: 59.0 60.0 60.0 58.0 57.0 58.0 59.0 66.0 57.0 56.0 17:24:15 INFO - PROCESS | 15137 | 17:24:15 INFO - PROCESS | 15137 | [#9] json-stringify-tinderbox Cycles:10 Average:66.80 Median:67.00 stddev:0.79 (1.2%) stddev-sans-first:0.78 17:24:15 INFO - PROCESS | 15137 | Values: 66.0 66.0 67.0 67.0 67.0 66.0 66.0 68.0 67.0 68.0 17:24:15 INFO - PROCESS | 15137 | 17:24:15 INFO - PROCESS | 15137 | [#10] stanford-crypto-aes Cycles:10 Average:85.20 Median:85.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 17:24:15 INFO - PROCESS | 15137 | Values: 86.0 85.0 86.0 85.0 85.0 85.0 85.0 84.0 86.0 85.0 17:24:15 INFO - PROCESS | 15137 | 17:24:15 INFO - PROCESS | 15137 | [#11] stanford-crypto-ccm Cycles:10 Average:119.80 Median:120.00 stddev:3.29 (2.7%) stddev-sans-first:3.28 17:24:15 INFO - PROCESS | 15137 | Values: 123.0 116.0 116.0 124.0 117.0 119.0 121.0 118.0 119.0 125.0 17:24:15 INFO - PROCESS | 15137 | 17:24:15 INFO - PROCESS | 15137 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.00 Median:153.00 stddev:6.07 (4.0%) stddev-sans-first:5.50 17:24:15 INFO - PROCESS | 15137 | Values: 140.0 156.0 153.0 153.0 154.0 141.0 153.0 149.0 150.0 141.0 17:24:15 INFO - PROCESS | 15137 | 17:24:15 INFO - PROCESS | 15137 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.00 stddev:0.94 (1.4%) stddev-sans-first:0.93 17:24:15 INFO - PROCESS | 15137 | Values: 68.0 66.0 67.0 66.0 67.0 67.0 66.0 67.0 67.0 69.0 17:24:15 INFO - PROCESS | 15137 | -------- Summary: end -------- 17:24:15 INFO - PROCESS | 15137 | 17:24:16 INFO - TEST-INFO | 15137: exit 0 17:24:16 INFO - TEST-OK | kraken | took 58702ms 17:24:16 INFO - TEST-START | v8_7 17:24:16 INFO - operating with platform_type : linux_ 17:24:16 INFO - Initialising browser for v8_7 test... 17:24:16 INFO - TEST-INFO | started process 15387 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp_HoUuk/profile http://localhost:45078/getInfo.html) 17:24:20 INFO - PROCESS | 15387 | __metrics Screen width/height:1600/1200 17:24:20 INFO - PROCESS | 15387 | colorDepth:24 17:24:20 INFO - PROCESS | 15387 | Browser inner width/height: 1024/697 17:24:20 INFO - PROCESS | 15387 | __metrics 17:24:21 INFO - PROCESS | 15387 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:24:21 INFO - PROCESS | 15387 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:24:21 ERROR - PROCESS | 15387 | JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 17:24:21 INFO - TEST-INFO | 15387: exit 0 17:24:21 INFO - Browser initialized. 17:24:21 INFO - Running cycle 1/1 for v8_7 test... 17:24:21 INFO - TEST-INFO | started process 15470 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp_HoUuk/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:24:33 INFO - PROCESS | 15470 | RSS: Main: 149893120 17:24:33 INFO - PROCESS | 15470 | 17:24:55 INFO - PROCESS | 15470 | Cycle 1(1): loaded http://localhost:45078/tests/v8_7/run.html (next: http://localhost:45078/tests/v8_7/run.html) 17:24:55 INFO - PROCESS | 15470 | RSS: Main: 615940096 17:24:55 INFO - PROCESS | 15470 | 17:24:55 INFO - PROCESS | 15470 | __start_tp_report 17:24:55 INFO - PROCESS | 15470 | _x_x_mozilla_page_load 17:24:55 INFO - PROCESS | 15470 | _x_x_mozilla_page_load_details 17:24:55 INFO - PROCESS | 15470 | |i|pagename|runs| 17:24:55 INFO - PROCESS | 15470 | |0;Richards;165.6726308813784 17:24:55 INFO - PROCESS | 15470 | |1;DeltaBlue;188.14675446848543 17:24:55 INFO - PROCESS | 15470 | |2;Encrypt;280.42624789680315 17:24:55 INFO - PROCESS | 15470 | |3;Decrypt;5148.717948717948 17:24:55 INFO - PROCESS | 15470 | |4;RayTrace;1976.2845849802372 17:24:55 INFO - PROCESS | 15470 | |5;Earley;782.4726134585289 17:24:55 INFO - PROCESS | 15470 | |6;Boyer;11976.190476190477 17:24:55 INFO - PROCESS | 15470 | |7;RegExp;25769.23076923077 17:24:55 INFO - PROCESS | 15470 | |8;Splay;648.1958762886597 17:24:55 INFO - PROCESS | 15470 | |9;NavierStokes;4835.748792270531 17:24:55 INFO - PROCESS | 15470 | __end_tp_report 17:24:55 INFO - PROCESS | 15470 | __startTimestamp1450833895294__endTimestamp 17:24:55 INFO - PROCESS | 15470 | 17:24:55 INFO - PROCESS | 15470 | ------- Summary: start ------- 17:24:55 INFO - PROCESS | 15470 | Number of tests: 10 17:24:55 INFO - PROCESS | 15470 | 17:24:55 INFO - PROCESS | 15470 | [#0] Richards Cycles:1 Average:165.67 Median:165.67 stddev:0.00 (0.0%) 17:24:55 INFO - PROCESS | 15470 | Values: 165.7 17:24:55 INFO - PROCESS | 15470 | 17:24:55 INFO - PROCESS | 15470 | [#1] DeltaBlue Cycles:1 Average:188.15 Median:188.15 stddev:0.00 (0.0%) 17:24:55 INFO - PROCESS | 15470 | Values: 188.1 17:24:55 INFO - PROCESS | 15470 | 17:24:55 INFO - PROCESS | 15470 | [#2] Encrypt Cycles:1 Average:280.43 Median:280.43 stddev:0.00 (0.0%) 17:24:55 INFO - PROCESS | 15470 | Values: 280.4 17:24:55 INFO - PROCESS | 15470 | 17:24:55 INFO - PROCESS | 15470 | [#3] Decrypt Cycles:1 Average:5148.72 Median:5148.72 stddev:0.00 (0.0%) 17:24:55 INFO - PROCESS | 15470 | Values: 5148.7 17:24:55 INFO - PROCESS | 15470 | 17:24:55 INFO - PROCESS | 15470 | [#4] RayTrace Cycles:1 Average:1976.28 Median:1976.28 stddev:0.00 (0.0%) 17:24:55 INFO - PROCESS | 15470 | Values: 1976.3 17:24:55 INFO - PROCESS | 15470 | 17:24:55 INFO - PROCESS | 15470 | [#5] Earley Cycles:1 Average:782.47 Median:782.47 stddev:0.00 (0.0%) 17:24:55 INFO - PROCESS | 15470 | Values: 782.5 17:24:55 INFO - PROCESS | 15470 | 17:24:55 INFO - PROCESS | 15470 | [#6] Boyer Cycles:1 Average:11976.19 Median:11976.19 stddev:0.00 (0.0%) 17:24:55 INFO - PROCESS | 15470 | Values: 11976.2 17:24:55 INFO - PROCESS | 15470 | 17:24:55 INFO - PROCESS | 15470 | [#7] RegExp Cycles:1 Average:25769.23 Median:25769.23 stddev:0.00 (0.0%) 17:24:55 INFO - PROCESS | 15470 | Values: 25769.2 17:24:55 INFO - PROCESS | 15470 | 17:24:55 INFO - PROCESS | 15470 | [#8] Splay Cycles:1 Average:648.20 Median:648.20 stddev:0.00 (0.0%) 17:24:55 INFO - PROCESS | 15470 | Values: 648.2 17:24:55 INFO - PROCESS | 15470 | 17:24:55 INFO - PROCESS | 15470 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 17:24:55 INFO - PROCESS | 15470 | Values: 4835.7 17:24:55 INFO - PROCESS | 15470 | -------- Summary: end -------- 17:24:55 INFO - PROCESS | 15470 | 17:24:56 INFO - TEST-INFO | 15470: exit 0 17:24:56 INFO - TEST-OK | v8_7 | took 39409ms 17:24:56 INFO - SUITE-END | took 1211s 17:24:56 INFO - Completed test suite (00:20:11) 17:24:56 INFO - Working with test: dromaeo_css 17:24:56 INFO - Generating results file: dromaeo_css 17:24:56 INFO - Working with test: kraken 17:24:56 INFO - Generating results file: kraken 17:24:56 INFO - javascript benchmark 17:24:56 INFO - Working with test: v8_7 17:24:56 INFO - Generating results file: v8_7 17:24:56 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:24:56 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 17:24:56 INFO - process_Request line: dromaeo_css 6896.82 graph.html#tests=[[72,64,35]] 17:24:56 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:24:56 INFO - process_Request line: kraken 1497.20 graph.html#tests=[[232,64,35]] 17:24:56 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:24:56 INFO - process_Request line: v8_7 19795.49 graph.html#tests=[[230,64,35]] 17:24:56 INFO - RETURN: dromaeo_css: 6896.82 17:24:56 INFO - RETURN: kraken: 1497.20 17:24:56 INFO - RETURN: v8_7: 19795.49 17:24:56 INFO - javascript benchmark 17:24:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3081.8459077046145, 3149.3543823516184, 3193.409219294431, 3199.632042315133, 3219.356128774245, 5099.133147364948, 5183.792648294064, 5271.894562108756, 5312.987412948668, 5372.543333816626, 5129.0767661820855, 5164.6384753067305, 5192.247124166994, 5222.981518603874, 5254.343207099113, 4785.712857228577, 4847.975760121194, 4851.854444366674, 4886.902261954759, 4948.925766113512, 4878.512148785111, 4888.462269150391, 4904.190808516609, 4933.506649335073, 4958.305837182779, 4625.514320996297, 4736.83421080264, 4739.336492890998, 4803.2554953981835, 4831.951680483186, 4774.73738944358, 4799.616030717534, 4801.4718380978065, 4808.663393562417, 4844.103840789465, 4751.477337492873, 4769.785359658824, 4789.80840766369, 4799.688020278671, 4846.9515304846855, 4881.585065269456, 4995.975020124913, 5047.924281135786, 5129.487051294878, 5186.118359878829, 5660.094384898438, 5673.773049078032, 5684.175794509814, 5684.289463817023, 5687.943120568824, 5685.857853553653, 5686.658800471985, 5716.942830571683, 5718.885622287531, 5730.742116604721, 5153.304303918961, 5236.842894713165, 5247.291615631917, 5253.605979551511, 5332.9466705333225, 5781.971090144522, 5785.0, 5785.450382213683, 5824.796132135355, 5841.269841269841, 5553.389127196006, 5558.805441809598, 5559.388467268597, 5565.248691426606, 5566.916496252559, 5473.0, 5511.53151982078, 5566.944330556724, 5594.384617692051, 5701.429857014348, 5601.159826026047, 5621.8594535136945, 5622.606417550732, 5625.746841392147, 5696.658200507983, 5612.186232996192, 5614.185943038318, 5615.18579805934, 5619.353774316006, 5625.128105143709, 4293.892652683646, 4373.9343909840745, 4374.300111982131, 4377.496587892433, 4406.691531592758, 3896.7661940283674, 3926.3521518949055, 3946.723729338976, 3960.0693836948294, 3968.6428221460205, 5315.176147697113, 5321.866953326198, 5325.174597937326, 5332.92000619991, 5334.11987022137, 5632.915506267409, 5653.095504719226, 5658.377578466366, 5664.971675141598, 5711.371749107595, 5197.974010129925, 5260.263563101169, 5276.314079169683, 5305.628605997543, 5313.8937221255355, 4859.489753575895, 4860.198067318853, 4882.51174882516, 4891.461939186686, 4910.975445122752, 5723.59934804568, 5734.0, 5741.311042674905, 5742.655440673573, 5750.7987220447085, 5476.288082549243, 5571.0807716726285, 5575.968445837533, 5686.60193786431, 5693.174489699053, 5639.689817060101, 5675.68783716883, 5676.602637815313, 5691.857703557279, 5746.482816546531, 5501.642393244587, 5548.611597188158, 5558.110702287615, 5559.58303127259, 5561.582881284001, 5456.727163641723, 5547.7780888764, 5552.361478429871, 5568.1091025435735, 5581.079121944996, 5480.753366098615, 5497.587680923867, 5504.80733174337, 5507.091329930517, 5509.118541033576, 5480.972595136999, 5486.561075113901, 5487.506124448819, 5488.039593071277, 5501.229827824188, 5323.973380133075, 5412.377576578744, 5497.890042199214, 5498.147787093007, 5503.9174412383045, 5520.7515661796115, 5596.1605759136455, 5601.887962240814, 5606.803761868315, 5627.0, 5229.058769421388, 5325.786968521215, 5328.62699611039, 5481.095619222783, 5516.034693928466], "unit": "score", "name": "dojo.html", "value": 5193.629317581294}, {"lowerIsBetter": false, "replicates": [557.4136008918617, 594.5629961977945, 609.135028259871, 615.9353267906872, 621.1955517604704, 27607.861960690192, 38688.226235475275, 38935.0, 39358.60641393585, 39379.0, 42478.787606062004, 42992.14015719692, 43109.35335969963, 43176.352354714705, 43198.35202471966, 7578.65896034677, 7668.156502784689, 8694.174053464927, 8882.46705197687, 9958.90041099587, 10219.54012069455, 10362.896371036268, 10367.844482332772, 10378.221633377489, 10378.584856605727, 10211.183105351554, 10283.382997020166, 10286.897131028707, 10290.125339346127, 10323.793524129513, 7799.532028078305, 7996.48022878514, 10415.16678665705, 10637.0, 10658.147348212124, 10040.29717919746, 10112.089911907964, 10146.391216526958, 10167.949160254151, 10177.0, 39406.80296598528, 39799.60200397988, 39837.402438963436, 39907.0, 39909.0, 3331.1006028372444, 3460.446328587439, 3466.6533346665383, 3694.0949467380665, 3795.2409518096492, 29502.40995180106, 29539.85230073836, 29557.0, 29665.703342966724, 30000.399992000257, 3848.6536211741077, 3871.8838434846716, 3955.149642826806, 3978.6618137458063, 4005.83976640934, 276454.0, 277693.0, 278305.0, 278733.0, 278988.0, 53448.73275633597, 57163.14255286174, 57208.42791572114, 57766.133507997416, 57797.0, 50806.49193508018, 66653.33346666569, 67887.0, 67912.0, 67929.66035169792, 15492.225388730518, 15776.842231577537, 15782.842171578366, 15784.763228551581, 15786.60533486649, 11851.585194518151, 11949.462274197682, 11987.280763154238, 11987.460564274628, 11988.100892433102, 18771.530711732317, 18778.342758003404, 18780.248790048245, 18895.43313700591, 19053.904730476257, 7378.372838308804, 7633.274838890296, 7638.541687498657, 7653.846923061507, 7676.232376762391, 934.243262957007, 1035.5805898611075, 1039.5114296280735, 1096.7477480179602, 1147.1951923268289, 27843.860780695966, 27926.0, 28026.71973280282, 28173.43653126926, 28265.293367665974, 1050.2333296693457, 1073.2487258918788, 1104.0394856474918, 1114.6098865397046, 1115.5330740076772, 14388.784168237486, 14503.347349369304, 15467.0, 16066.518004459886, 16276.674466510603, 457240.0, 466541.0, 467024.0, 467540.0, 469158.0, 48847.5115248843, 49098.263526047136, 49179.754101229264, 49324.75337623289, 49449.0, 1350.3450826349213, 1356.8575299593401, 1363.6181869076675, 1393.0248825821966, 1504.3456096597797, 24194.63708044416, 26978.32554186161, 27851.860740696167, 29384.95672509982, 30168.5474717875, 44084.779576101915, 44287.778561106985, 44457.33314000228, 44633.55366446294, 44752.77623611861, 250070.0, 254405.0, 254423.55094020444, 256797.0, 257431.0, 26254.212373628823, 27391.0, 27518.724812752418, 27632.447351052466, 30109.096727098222, 35809.28381432305, 37248.44127338038, 37319.44020839635, 41431.585684142774, 42325.36511952385, 31256.374872502878, 31991.6800831998, 32490.837545813065, 32819.50770738393, 32922.0, 28757.0, 33784.49323260202, 35285.0, 35596.28807423889, 35780.28439431249, 28834.567481487375, 34370.484442733876, 34435.65564344324, 34448.483272750425, 34494.82752586221, 27708.445831082863, 31191.84404077965, 33631.76487492107, 33676.0, 33676.49485257772, 25241.063553568954, 25262.87368563219, 25571.36071598225, 25624.103156389436, 25703.485930280916], "unit": "score", "name": "ext.html", "value": 18682.389587905065}, {"lowerIsBetter": false, "replicates": [358.7363287983332, 360.60693843710357, 362.18508356198555, 365.86280144945647, 366.6809875408395, 13632.659183520416, 13698.726025479484, 16727.33090676373, 16805.159742012896, 17119.288071192874, 12925.612231633066, 15647.374105035813, 15679.764803527956, 15900.045997240173, 16050.59873503163, 5125.589952803767, 5247.790088396459, 5247.868803279929, 5250.894982100355, 5251.842444726664, 3904.1606054698236, 4012.5385580658162, 5094.032133894567, 5222.32109825724, 5233.685978841263, 5829.329627092875, 5950.315713692938, 5989.401059894019, 6004.489618382443, 6010.0, 5686.0, 5773.971130144364, 5788.942110578882, 5930.288365396137, 5937.67342796146, 5241.86895327616, 5254.973725131388, 5257.76340064698, 5258.39528454225, 5259.421463638997, 19560.413187604394, 19831.603367932705, 20030.69953950692, 20103.095360708805, 20109.0, 2211.159759291475, 2280.749117597063, 2343.7656234376595, 2459.8155138364514, 2534.1763926723706, 12883.935580322039, 12955.805662915063, 13070.86929130706, 13317.334133293394, 13521.053526253167, 1784.50925995351, 1844.4558855137766, 1887.782904965919, 1904.0670071664922, 1915.82757551821, 55534.0, 57702.422975770125, 58701.0, 58917.410825891624, 59356.0, 9573.138417542455, 9887.851682224773, 9926.553305101288, 9967.0, 10049.59801607942, 12786.872131278567, 12850.421731022127, 12860.935695321463, 12863.807042894365, 12869.742605147845, 7738.845223095506, 7778.64996075178, 7783.299503044753, 7784.416168787364, 7790.454668173287, 7578.09062912454, 7588.886166707503, 7590.127135379392, 7642.923570764332, 7648.349890259279, 5844.064949608127, 5878.265911556101, 5923.733431995571, 5925.762969481259, 5966.075258334965, 1660.2777791660667, 1700.5493544210794, 1756.481837857835, 1794.5414781748827, 1805.4764118405778, 394.93878448840474, 401.34179944890406, 426.96674048801975, 989.9604015839286, 1013.6046941692746, 9455.479948602893, 9692.321537492307, 10014.49927503622, 10026.69919902404, 10089.596416143419, 447.3468735645993, 827.8840962265288, 837.5728378526995, 918.9540522973824, 943.7970836270235, 8864.64541418349, 9270.629174832931, 9754.073363030642, 9817.214622830157, 9822.557984890696, 542368.2881585567, 552962.0, 559869.0, 562317.0, 565902.0, 42830.357544636856, 43022.35466468005, 43177.35233971493, 71192.18540662731, 78949.0, 1120.0983208517223, 1142.994285028586, 1151.9596814111467, 1177.1112809828526, 1193.200555627714, 14705.41178352854, 15439.84560154384, 15671.294791734172, 15762.561916138913, 15890.205489725698, 34819.65180348265, 35442.8227858859, 35589.28821423609, 36311.455328170625, 36529.0, 46684.299735504675, 47620.7618961903, 48365.27452088292, 48880.26679599738, 50978.49021509737, 9007.864882026906, 9049.321300902327, 9076.41003334781, 9278.860817087614, 9300.767480813034, 10683.198760092868, 10822.458877055959, 10828.458577071273, 15611.921940390226, 17169.0, 13510.392032358764, 13720.588382348546, 14451.349689264218, 14531.0, 14651.413943442569, 8855.070217627057, 8962.103789621247, 9279.257659387098, 13876.58370248894, 13998.860011399756, 9868.210543156674, 9935.20518358515, 10004.099631033241, 10044.748881278027, 10187.286889917634, 13842.169469831439, 14407.783883241551, 14587.635309117357, 15259.771103433679, 15286.847131528542, 15047.89319569192, 15332.616684582974, 15490.84509154939, 15665.765013524579, 16228.594285142966], "unit": "score", "name": "jquery.html", "value": 8576.232660740186}, {"lowerIsBetter": false, "replicates": [1470.514730139054, 1528.1289664891012, 1581.2410043179273, 1664.284357726178, 1769.6372243690053, 6410.423061924426, 7432.851342973144, 7584.7724568262975, 7593.392528597713, 7597.810054748634, 7424.665890034948, 7584.127825300092, 7588.848223035536, 7593.658285377158, 7598.924010759891, 1913.550315675815, 1951.6877299632063, 1953.4432686684297, 2246.0454306919573, 2291.8051965582945, 1960.9313674021412, 2233.3300009997015, 2289.599320118981, 2290.633498640218, 2299.942501437469, 2213.181122984498, 2244.8091912187483, 2252.5044490212126, 2260.1750361118156, 2262.875541845198, 2209.8232141428725, 2210.0165426385265, 2222.7777222277805, 2231.564844855254, 2236.541508990653, 2254.9774502255095, 2275.4993901341677, 2276.5105502316915, 2277.089164334263, 2278.4303924018996, 7436.962815185943, 7506.43701722373, 7507.8498430031095, 7511.173770885198, 7516.173220945691, 4538.115067561826, 4610.469795973472, 4619.145458090264, 4619.5611416915335, 4620.491745907947, 2925.18094933419, 2938.412317536501, 2963.955540666892, 2984.910452686423, 2998.0, 973.090160699748, 1002.4085789384299, 1032.7005168501125, 1036.041661463151, 1049.574922156528, 10210.489475526194, 10219.18246540275, 10222.386656800616, 10227.079562839306, 10240.590376384936, 4162.4796900387455, 4186.476690413699, 4230.069384735353, 4237.597428244312, 4261.957380426218, 8824.647014119364, 8830.779230519289, 8835.293176545862, 8835.64657413709, 8848.380613357003, 4518.983228773565, 4524.411826462605, 4543.341215523797, 4554.43069616298, 4566.269396896547, 4101.26177288091, 4138.896527586834, 4144.026153853842, 4145.17096580685, 4149.294619914622, 3144.119646498984, 3185.4425475542153, 3622.5109610202812, 3643.5081264029545, 3697.6672099510633, 1152.7521582859727, 1167.4921409186861, 1169.8011338072547, 1179.1392283632997, 1179.292424545266, 1067.3809190669392, 1088.6570730220114, 1088.9945550272198, 1218.9512419503299, 1322.4379638653534, 7001.36987671112, 7181.676824542908, 7256.129264488295, 7257.92742072583, 7261.0, 1094.3324572011068, 1110.2783190925802, 1123.0566324287638, 1126.5268587193398, 1147.0995268714018, 5660.405657405995, 5661.688607126647, 5731.541476681856, 5760.07838745807, 5760.740766665426, 8843.69047083349, 8912.420692654956, 9046.185843274005, 9048.140426659456, 9054.81890362189, 8689.782755431164, 8930.821383572293, 9036.909630903738, 9072.092790720875, 9072.364934454525, 7058.788236352918, 7080.327368899946, 7085.82285442868, 7117.395021423237, 7151.0, 6874.759383421556, 6918.930810691829, 6939.306069393222, 6972.860542789217, 7008.824779380352, 7701.152873184057, 7929.286364227247, 8029.0, 8123.106458289702, 8226.30076443509, 8203.466774659628, 8343.2908202801, 8362.0, 8405.495670259805, 8446.0, 6399.072134540373, 6500.707468164039, 6555.082288479522, 6555.967220163869, 6567.835804104936, 6220.315765265726, 6274.403931626488, 6855.6572171390235, 7267.672954717156, 7278.745243916649, 6777.6272305023695, 6824.761133360308, 6869.450443964371, 6918.55029423106, 6974.128233970754, 6657.500687448558, 6674.332566743481, 6676.532642715158, 6708.060871477899, 6845.281245469353, 6672.332766723289, 6703.564268322543, 6704.094947182068, 6709.161354830646, 6711.832204194934, 6170.660613666112, 6260.812175634738, 6261.154744109669, 6303.716332764945, 6306.400891915261, 6293.653849038347, 6325.399087086719, 6326.715297811517, 6334.524910631629, 6336.17629708135], "unit": "score", "name": "mootools.html", "value": 4361.558026192739}, {"lowerIsBetter": false, "replicates": [335.48838022016423, 339.76216648346156, 341.8376271271147, 342.77034386960736, 349.71323514717943, 5936.287645482543, 5976.133460648209, 5991.161237426763, 5997.550183736221, 6011.857747028062, 5673.602847800656, 5766.509846663039, 5804.738786754596, 5904.468597826195, 5925.61483503572, 4549.636029117679, 4601.12578610063, 4626.6298696104395, 4631.212693842055, 4643.257078867382, 4606.976965115186, 4621.976890115545, 4623.0, 4627.259638457847, 4645.3264276679865, 4348.456442944632, 4421.712588681726, 4500.864974050767, 4607.585317321457, 4608.608268297199, 4576.656750743708, 4597.54024597541, 4598.0, 4599.931001034987, 4610.031893302394, 4040.252553277653, 4050.2709512287774, 4054.4526488924207, 4064.268431682296, 4085.5710150434074, 5640.717964101778, 5650.802221922254, 5660.009498337816, 5663.773449062074, 5679.630823996427, 5181.145111056671, 5305.946940530623, 5320.388155362106, 5353.678779273256, 5356.276902618136, 6310.179676642053, 6315.5894866833505, 6320.557560970734, 6327.367263273682, 6329.873402531924, 4416.447944006999, 4416.845410410652, 4419.513853476115, 4422.977885110586, 4426.358178064195, 6433.067205255258, 6574.079628851917, 6590.868182636368, 6613.768518101843, 6645.468362530986, 4500.864974050718, 4504.09918016398, 4515.503294637587, 4515.841945531956, 4516.3902873112365, 4570.4743954445, 4574.862754117382, 4575.22221222393, 4576.107659006529, 4577.427821522309, 5263.473652634706, 5273.525382715574, 5285.762140703678, 5287.867803304871, 5289.761960711778, 6225.937740622536, 6326.841828954221, 6350.650714210763, 6358.491320694426, 6358.713857876407, 1584.3504163292994, 1614.4268784581539, 1614.5640677017375, 1614.741641337404, 1614.765858950469, 1073.9892601074046, 1086.277625379114, 1087.8531398261134, 1102.7904698107334, 1111.4053981120062, 6131.478824299985, 6133.049377346519, 6134.141220229171, 6136.570440069241, 6139.4781443577795, 6546.770863019867, 6551.475881929434, 6552.6068435894, 6553.180852393451, 6564.081028655992, 5931.377205393372, 5999.760009599567, 6094.39056094387, 6124.571280010446, 6126.203593532901, 3530.6292839252023, 3550.680438760524, 3565.322588708137, 3566.0728210665416, 3568.3041806847937, 6658.4673226141795, 6659.267480577133, 6662.100616416818, 6663.433608143362, 6666.466682665375, 6622.072909792633, 6767.39093481589, 6767.796966091025, 6775.1531058617675, 6775.796726098225, 6659.0, 6660.134182556237, 6660.733570657119, 6663.033860090357, 6663.300353462817, 6602.40578347951, 6608.074869518367, 6611.0, 6614.107095542233, 6621.039949207434, 6381.8723625528155, 6528.988006858945, 6533.901991470037, 6543.247526534319, 6561.0, 6638.734450621921, 6642.302558231316, 6647.933520664925, 6648.468122550281, 6676.866462670817, 4554.271316589462, 4555.840545580889, 4557.453105627346, 4558.726476411426, 4558.954410455853, 6439.903401448888, 6556.311587283267, 6613.834654133685, 6623.900641490285, 6639.070530125689, 6410.61536307823, 6419.582727122722, 6422.518311126778, 6423.068655044899, 6430.7749228776765, 6383.7765678202895, 6420.582662126947, 6427.132337134614, 6436.259830119596, 6442.130312407952, 6179.505639548735, 6289.339619340087, 6321.146645202839, 6321.336259692666, 6338.809835704937, 6454.709538070704, 6456.9354306456335, 6459.967700161469, 6468.288488266193, 6470.967645161744, 6301.873962520815, 6309.0, 6312.526560508072, 6312.873742525216, 6319.747210111544], "unit": "score", "name": "prototype.html", "value": 4799.975991796299}, {"lowerIsBetter": false, "replicates": [759.8138456078258, 786.5752493653425, 812.2933048248024, 831.5094094484253, 859.1451505751774, 13201.405936732846, 13674.589762307134, 13680.726385472284, 13686.110402823835, 13697.109687870281, 12740.80888786669, 12842.807357889638, 12942.935285323583, 13505.324733763322, 13540.526081587146, 664.6112024465693, 667.6995352091554, 804.5615139748836, 825.0635528674937, 825.1665817524314, 801.7274126796888, 818.8771684247381, 824.2581676491146, 824.575343697993, 824.7195953375851, 847.9194476524751, 861.2894362151219, 862.0216054777841, 862.6376921692904, 862.6980556805131, 698.9091418115638, 699.8915168148894, 832.7585000349891, 852.0754980845759, 855.687673998989, 615.8552740106071, 623.8970569855968, 625.5058503782006, 625.6777759453839, 625.974961001564, 13778.035537512378, 13938.512152074629, 13945.930270348685, 13946.790798138036, 13952.0, 12075.27548347102, 12338.938305308506, 12557.434915428828, 12634.72276327753, 12649.683757906034, 10004.949975250078, 10046.748831279276, 10310.793784124275, 10354.223433242538, 10467.424291663956, 3530.382183117944, 3590.5870824854956, 3614.963850361489, 3615.5480564929385, 3690.5940346561856, 44758.10483790338, 44802.77598611986, 45295.77352113251, 45303.0, 45500.544994549964, 9889.802203956024, 9983.251256155672, 9990.350627209207, 10001.049900259464, 10046.598136074475, 17985.0, 18212.0, 18311.450656480327, 18348.0, 18358.449246522625, 7077.858442831114, 7168.175659799085, 7247.23903990084, 7389.261073892568, 7492.887606685904, 4108.342665173558, 4147.875563733093, 4197.916041679149, 4205.074883525619, 4300.892477688083, 2977.389635124794, 2988.491956367423, 2993.9101826945225, 2995.3859458810894, 3006.2484378905274, 563.8026690658237, 564.7063526965954, 571.5284889965795, 574.3624576719837, 594.3402822866615, 574.4657468554201, 596.3350863786847, 598.5660396212711, 611.4955161991375, 611.6941529235382, 8273.751787446387, 8528.957355213184, 8602.698905538402, 8711.783098043768, 8763.211310982042, 516.3055690096813, 549.8350494851528, 571.3714913595012, 627.8242092214188, 661.3353579652419, 3772.9245415091546, 3806.2006978534264, 3964.4647972523917, 4105.137921036556, 4176.665866730655, 56609.7169514158, 57058.71470642703, 57197.71401142968, 57264.0, 57589.0, 48540.0, 49032.0, 49395.259071113964, 49528.257076143884, 49701.50298496969, 45423.31865022027, 45513.317300240524, 45816.312755308696, 46012.76993615078, 46055.078898421845, 7993.360531157377, 8091.514509129471, 8115.567911040414, 8136.145704701158, 8361.0, 32567.18582035468, 32988.0, 33154.0, 33796.32407351888, 34368.82815585906, 39128.608713912494, 39690.80154599324, 40156.0, 40360.59639403568, 41113.38329924994, 10521.894781052091, 10556.313839600401, 10613.9469302653, 10683.732906677395, 10832.837507437238, 11154.442277885912, 11431.599894004003, 11487.13846461502, 11487.94256028748, 12030.27818330903, 10952.835707464554, 11059.889401106208, 11294.265872718248, 11301.434928253719, 11400.258983166068, 11207.383593902088, 11432.07012758177, 11501.597444089752, 11660.825087623523, 11794.938455539042, 10733.731656708645, 11076.778464430505, 11563.479643415898, 11566.595169169039, 11574.363410012531, 9837.852432213665, 9970.40177589347, 10231.63631859284, 10297.74255643615, 10506.579736810441, 8965.865512017455, 9005.95497022537, 9169.862452063091, 9431.528423578931, 9447.0], "unit": "score", "name": "yui.html", "value": 6176.938210945642}], "name": "dromaeo_css", "value": 6896.821563932138}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 110.0, 104.0, 112.0, 111.0, 110.0, 99.0, 110.0, 109.0, 116.0], "unit": "score", "name": "ai-astar", "value": 109.0}, {"lowerIsBetter": true, "replicates": [148.0, 123.0, 152.0, 162.0, 126.0, 145.0, 151.0, 126.0, 167.0, 122.0], "unit": "score", "name": "audio-beat-detection", "value": 142.2}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 159.0, 160.0, 160.0, 160.0, 161.0, 167.0, 162.0, 163.0], "unit": "score", "name": "audio-dft", "value": 161.4}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 81.0, 96.0, 72.0, 71.0, 73.0, 111.0, 88.0, 73.0], "unit": "score", "name": "audio-fft", "value": 80.7}, {"lowerIsBetter": true, "replicates": [93.0, 102.0, 141.0, 93.0, 92.0, 92.0, 136.0, 94.0, 92.0, 134.0], "unit": "score", "name": "audio-oscillator", "value": 106.9}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 110.0, 109.0, 109.0, 110.0, 110.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.5}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 144.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.1}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [59.0, 60.0, 60.0, 58.0, 57.0, 58.0, 59.0, 66.0, 57.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 59.0}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 67.0, 67.0, 67.0, 66.0, 66.0, 68.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.8}, {"lowerIsBetter": true, "replicates": [86.0, 85.0, 86.0, 85.0, 85.0, 85.0, 85.0, 84.0, 86.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.2}, {"lowerIsBetter": true, "replicates": [123.0, 116.0, 116.0, 124.0, 117.0, 119.0, 121.0, 118.0, 119.0, 125.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.8}, {"lowerIsBetter": true, "replicates": [140.0, 156.0, 153.0, 153.0, 154.0, 141.0, 153.0, 149.0, 150.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.0}, {"lowerIsBetter": true, "replicates": [68.0, 66.0, 67.0, 66.0, 67.0, 67.0, 66.0, 67.0, 67.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.0}], "name": "kraken", "value": 1497.2}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.6726308813784], "unit": "score", "name": "Richards", "value": 213.0828719999999}, {"lowerIsBetter": false, "replicates": [188.14675446848543], "unit": "score", "name": "DeltaBlue", "value": 351.41717}, {"lowerIsBetter": false, "replicates": [280.42624789680315], "unit": "score", "name": "Encrypt", "value": 949.2014460000001}, {"lowerIsBetter": false, "replicates": [5148.717948717948], "unit": "score", "name": "Decrypt", "value": 51.69850099601596}, {"lowerIsBetter": false, "replicates": [1976.2845849802372], "unit": "score", "name": "RayTrace", "value": 374.434434}, {"lowerIsBetter": false, "replicates": [782.4726134585289], "unit": "score", "name": "Earley", "value": 851.7397139999999}, {"lowerIsBetter": false, "replicates": [11976.190476190477], "unit": "score", "name": "Boyer", "value": 55.648998011928406}, {"lowerIsBetter": false, "replicates": [25769.23076923077], "unit": "score", "name": "RegExp", "value": 35.3516567164179}, {"lowerIsBetter": false, "replicates": [648.1958762886597], "unit": "score", "name": "Splay", "value": 125.7197137176938}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 19795.493692089487}]} 17:24:56 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "19795.49"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1497.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6896.82"}}} 17:24:56 INFO - Return code: 0 17:24:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 17:24:56 ERROR - # TBPL SUCCESS # 17:24:56 INFO - Running post-action listener: _resource_record_post_action 17:24:56 INFO - Running post-run listener: _resource_record_post_run 17:24:57 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 8192; Write bytes: 558915584; Read time: 100; Write time: 844572 17:24:57 INFO - install - Wall time: 16s; CPU: 16.0%; Read bytes: 0; Write bytes: 251817984; Read time: 0; Write time: 530384 17:24:57 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 8192; Write bytes: 306233344; Read time: 100; Write time: 314144 17:24:57 INFO - Running post-run listener: _upload_blobber_files 17:24:57 INFO - Blob upload gear active. 17:24:57 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 17:24:57 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:24:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 17:24:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 17:24:58 INFO - (blobuploader) - INFO - Open directory for files ... 17:24:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 17:24:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:24:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:24:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:24:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:24:58 INFO - (blobuploader) - INFO - Done attempting. 17:24:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:24:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:24:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:24:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:24:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:24:59 INFO - (blobuploader) - INFO - Done attempting. 17:24:59 INFO - (blobuploader) - INFO - Iteration through files over. 17:24:59 INFO - Return code: 0 17:24:59 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 17:24:59 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 17:24:59 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3c11184ba62f1a3ee339a5ad376be2973b01c9b58717ba75ce04f8ee106b3ec1704c6561614236a9c5fbd276dac0e1bc793f204b00e986c3d45c53c3c57ce988", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0b42128f617880e9a52ea0e962d62ecb0d76a73a67a9b2a1608806f46d2e900a31b6102cc16a3dc498e8b9417434d2010d892dd22c7c9602e6171019e512b66f"} 17:24:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 17:24:59 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 17:24:59 INFO - Contents: 17:24:59 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3c11184ba62f1a3ee339a5ad376be2973b01c9b58717ba75ce04f8ee106b3ec1704c6561614236a9c5fbd276dac0e1bc793f204b00e986c3d45c53c3c57ce988", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0b42128f617880e9a52ea0e962d62ecb0d76a73a67a9b2a1608806f46d2e900a31b6102cc16a3dc498e8b9417434d2010d892dd22c7c9602e6171019e512b66f"} 17:24:59 INFO - Copying logs to upload dir... 17:24:59 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1267.536918 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2015-12-22 17:24:59.204679) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-22 17:24:59.208904) ========= 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=e25b24362c3bb3dea6e300e4000001c1-1450831259.767204-550062830 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3c11184ba62f1a3ee339a5ad376be2973b01c9b58717ba75ce04f8ee106b3ec1704c6561614236a9c5fbd276dac0e1bc793f204b00e986c3d45c53c3c57ce988", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0b42128f617880e9a52ea0e962d62ecb0d76a73a67a9b2a1608806f46d2e900a31b6102cc16a3dc498e8b9417434d2010d892dd22c7c9602e6171019e512b66f"} build_url:https://queue.taskcluster.net/v1/task/JDjODWhqTOqY6mOmBWxxMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011236 build_url: 'https://queue.taskcluster.net/v1/task/JDjODWhqTOqY6mOmBWxxMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3c11184ba62f1a3ee339a5ad376be2973b01c9b58717ba75ce04f8ee106b3ec1704c6561614236a9c5fbd276dac0e1bc793f204b00e986c3d45c53c3c57ce988", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0b42128f617880e9a52ea0e962d62ecb0d76a73a67a9b2a1608806f46d2e900a31b6102cc16a3dc498e8b9417434d2010d892dd22c7c9602e6171019e512b66f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-22 17:24:59.232722) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 17:24:59.233034) ========= 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=e25b24362c3bb3dea6e300e4000001c1-1450831259.767204-550062830 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004496 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 17:24:59.289309) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-22 17:24:59.289679) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-22 17:24:59.289976) ========= ========= Total master_lag: 0.26 =========