builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-023 starttime: 1453293732.21 results: success (0) buildid: 20160120013040 builduid: 7fbda577b04d43719bc50d593d889743 revision: 39f56e62c694ea209ab0013a4c357084e7ed67ce ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-20 04:42:12.207420) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-20 04:42:12.207931) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-20 04:42:12.208225) ========= 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=6d15e502d8e29d5d2676d664000001c3-1453293731.609659-1163643961 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.005005 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-20 04:42:12.229817) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-20 04:42:12.230184) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-20 04:42:12.250047) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 04:42:12.250422) ========= 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=6d15e502d8e29d5d2676d664000001c3-1453293731.609659-1163643961 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.027753 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 04:42:12.299908) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-20 04:42:12.300209) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-20 04:42:12.300624) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 04:42:12.300918) ========= 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=6d15e502d8e29d5d2676d664000001c3-1453293731.609659-1163643961 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-20 04:42:12-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 19.1M=0.001s 2016-01-20 04:42:12 (19.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.162923 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 04:42:12.476676) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 04:42:12.476997) ========= 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=6d15e502d8e29d5d2676d664000001c3-1453293731.609659-1163643961 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.042741 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 04:42:12.532246) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 04:42:12.532613) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 39f56e62c694ea209ab0013a4c357084e7ed67ce --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/mozilla-inbound --rev 39f56e62c694ea209ab0013a4c357084e7ed67ce --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=6d15e502d8e29d5d2676d664000001c3-1453293731.609659-1163643961 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-20 04:42:12,736 truncating revision to first 12 chars 2016-01-20 04:42:12,736 Setting DEBUG logging. 2016-01-20 04:42:12,736 attempt 1/10 2016-01-20 04:42:12,736 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/39f56e62c694?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-20 04:42:13,040 unpacking tar archive at: mozilla-inbound-39f56e62c694/testing/mozharness/ program finished with exit code 0 elapsedTime=0.579485 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 04:42:13.124310) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-20 04:42:13.124645) ========= echo '%(revision)s' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', '%(revision)s'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1453293731.609659-1163643961 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False %(revision)s program finished with exit code 0 elapsedTime=0.003649 script_repo_revision: '%(revision)s' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-20 04:42:13.172929) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-20 04:42:13.173271) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-20 04:42:13.183174) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-20 04:42:13.183558) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/%(revision)s ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-20 04:42:13.184037) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-01-20 04:42:13.184323) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1453293731.609659-1163643961 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:42:13 INFO - MultiFileLogger online at 20160120 04:42:13 in /builds/slave/test-pgo 04:42:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 04:42:13 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 04:42:13 INFO - {'append_to_log': False, 04:42:13 INFO - 'base_work_dir': '/builds/slave/test-pgo', 04:42:13 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 04:42:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 04:42:13 INFO - 'branch': 'Mozilla-Inbound', 04:42:13 INFO - 'buildbot_json_path': 'buildprops.json', 04:42:13 INFO - 'config_files': ('talos/linux_config.py',), 04:42:13 INFO - 'default_actions': ('clobber', 04:42:13 INFO - 'read-buildbot-config', 04:42:13 INFO - 'download-and-extract', 04:42:13 INFO - 'populate-webroot', 04:42:13 INFO - 'create-virtualenv', 04:42:13 INFO - 'install', 04:42:13 INFO - 'run-tests'), 04:42:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:42:13 INFO - 'download_minidump_stackwalk': True, 04:42:13 INFO - 'download_symbols': 'ondemand', 04:42:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:42:13 INFO - 'tooltool.py': '/tools/tooltool.py', 04:42:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:42:13 INFO - '/tools/misc-python/virtualenv.py')}, 04:42:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:42:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:42:13 INFO - 'installer_path': 'installer.exe', 04:42:13 INFO - 'log_level': 'info', 04:42:13 INFO - 'log_name': 'talos', 04:42:13 INFO - 'log_to_console': True, 04:42:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:42:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:42:13 INFO - 'opt_config_files': (), 04:42:13 INFO - 'pip_index': False, 04:42:13 INFO - 'sps_profile': False, 04:42:13 INFO - 'sps_profile_interval': 0, 04:42:13 INFO - 'suite': 'dromaeojs', 04:42:13 INFO - 'system_bits': '32', 04:42:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:42:13 INFO - 'title': 'talos-linux64-ix-023', 04:42:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:42:13 INFO - 'use_talos_json': True, 04:42:13 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 04:42:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:42:13 INFO - 'work_dir': 'build'} 04:42:13 INFO - ##### 04:42:13 INFO - ##### Running clobber step. 04:42:13 INFO - ##### 04:42:13 INFO - Running pre-action listener: _resource_record_pre_action 04:42:13 INFO - Running main action method: clobber 04:42:13 INFO - rmtree: /builds/slave/test-pgo/build 04:42:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 04:42:14 INFO - Running post-action listener: _resource_record_post_action 04:42:14 INFO - ##### 04:42:14 INFO - ##### Running read-buildbot-config step. 04:42:14 INFO - ##### 04:42:14 INFO - Running pre-action listener: _resource_record_pre_action 04:42:14 INFO - Running main action method: read_buildbot_config 04:42:14 INFO - Using buildbot properties: 04:42:14 INFO - { 04:42:14 INFO - "project": "", 04:42:14 INFO - "product": "firefox", 04:42:14 INFO - "script_repo_revision": "production", 04:42:14 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 04:42:14 INFO - "repository": "", 04:42:14 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 04:42:14 INFO - "buildid": "20160120013040", 04:42:14 INFO - "pgo_build": "True", 04:42:14 INFO - "basedir": "/builds/slave/test-pgo", 04:42:14 INFO - "buildnumber": 643, 04:42:14 INFO - "slavename": "talos-linux64-ix-023", 04:42:14 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:42:14 INFO - "platform": "ubuntu64_hw", 04:42:14 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 04:42:14 INFO - "branch": "mozilla-inbound", 04:42:14 INFO - "repo_path": "integration/mozilla-inbound", 04:42:14 INFO - "revision": "39f56e62c694ea209ab0013a4c357084e7ed67ce", 04:42:14 INFO - "stage_platform": "linux64-pgo", 04:42:14 INFO - "builduid": "7fbda577b04d43719bc50d593d889743", 04:42:14 INFO - "slavebuilddir": "test" 04:42:14 INFO - } 04:42:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/aSnZ95h1Qcei6o3qrDDWCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 04:42:14 INFO - Running post-action listener: _resource_record_post_action 04:42:14 INFO - ##### 04:42:14 INFO - ##### Running download-and-extract step. 04:42:14 INFO - ##### 04:42:14 INFO - Running pre-action listener: _resource_record_pre_action 04:42:14 INFO - Running main action method: download_and_extract 04:42:14 INFO - mkdir: /builds/slave/test-pgo/build/tests 04:42:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:42:14 INFO - https://queue.taskcluster.net/v1/task/aSnZ95h1Qcei6o3qrDDWCA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:42:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aSnZ95h1Qcei6o3qrDDWCA/artifacts/public/build/test_packages.json 04:42:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aSnZ95h1Qcei6o3qrDDWCA/artifacts/public/build/test_packages.json 04:42:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aSnZ95h1Qcei6o3qrDDWCA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 04:42:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aSnZ95h1Qcei6o3qrDDWCA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 04:42:15 INFO - Downloaded 1448 bytes. 04:42:15 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 04:42:15 INFO - Using the following test package requirements: 04:42:15 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:42:15 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:42:15 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:42:15 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:42:15 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:42:15 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:42:15 INFO - u'jsshell-linux-x86_64.zip'], 04:42:15 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:42:15 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:42:15 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:42:15 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:42:15 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:42:15 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:42:15 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:42:15 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:42:15 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:42:15 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:42:15 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:42:15 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:42:15 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:42: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')]} 04:42:15 INFO - https://queue.taskcluster.net/v1/task/aSnZ95h1Qcei6o3qrDDWCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:42:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aSnZ95h1Qcei6o3qrDDWCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:42:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aSnZ95h1Qcei6o3qrDDWCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:42:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aSnZ95h1Qcei6o3qrDDWCA/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 04:42:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aSnZ95h1Qcei6o3qrDDWCA/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 04:42:16 INFO - Downloaded 22484529 bytes. 04:42:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 04:42:16 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 04:42:17 INFO - Return code: 0 04:42:17 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 04:42:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:42:17 INFO - https://queue.taskcluster.net/v1/task/aSnZ95h1Qcei6o3qrDDWCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:42:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aSnZ95h1Qcei6o3qrDDWCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:42:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aSnZ95h1Qcei6o3qrDDWCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:42:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aSnZ95h1Qcei6o3qrDDWCA/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 04:42:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aSnZ95h1Qcei6o3qrDDWCA/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 04:42:18 INFO - Downloaded 22484529 bytes. 04:42:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 04:42:18 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 04:42:20 INFO - Return code: 0 04:42:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:42:20 INFO - https://queue.taskcluster.net/v1/task/aSnZ95h1Qcei6o3qrDDWCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:42:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aSnZ95h1Qcei6o3qrDDWCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:42:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aSnZ95h1Qcei6o3qrDDWCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:42:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aSnZ95h1Qcei6o3qrDDWCA/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 04:42:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aSnZ95h1Qcei6o3qrDDWCA/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 04:42:21 INFO - Downloaded 10705515 bytes. 04:42:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 04:42:21 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 04:42:22 INFO - Return code: 0 04:42: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')]} 04:42:22 INFO - https://queue.taskcluster.net/v1/task/aSnZ95h1Qcei6o3qrDDWCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:42:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aSnZ95h1Qcei6o3qrDDWCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:42:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aSnZ95h1Qcei6o3qrDDWCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:42:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aSnZ95h1Qcei6o3qrDDWCA/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 04:42:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aSnZ95h1Qcei6o3qrDDWCA/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 04:42:24 INFO - Downloaded 55948058 bytes. 04:42:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aSnZ95h1Qcei6o3qrDDWCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:42:24 INFO - mkdir: /builds/slave/test-pgo/properties 04:42:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 04:42:24 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 04:42:24 INFO - Contents: 04:42:24 INFO - build_url:https://queue.taskcluster.net/v1/task/aSnZ95h1Qcei6o3qrDDWCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:42:24 INFO - Running post-action listener: _resource_record_post_action 04:42:24 INFO - Running post-action listener: set_extra_try_arguments 04:42:24 INFO - ##### 04:42:24 INFO - ##### Running populate-webroot step. 04:42:24 INFO - ##### 04:42:24 INFO - Running pre-action listener: _resource_record_pre_action 04:42:24 INFO - Running main action method: populate_webroot 04:42:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:42:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:42:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:42:24 INFO - '--tppagecycles', 04:42:24 INFO - '7'], 04:42:24 INFO - 'tests': ['tsvgm']}}, 04:42:24 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:42:24 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:42:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:42:24 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:42:24 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:42:24 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:42:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:42:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:42:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:42:24 INFO - 'talos_options': ['--e10s'], 04:42:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:42:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:42:24 INFO - 'tests': ['damp', 'tps']}, 04:42:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:42:24 INFO - 'talos_options': ['--e10s'], 04:42:24 INFO - 'tests': ['damp', 'tps']}, 04:42:24 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:42:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:42:24 INFO - 'other': {'tests': ['a11yr', 04:42:24 INFO - 'ts_paint', 04:42:24 INFO - 'tpaint', 04:42:24 INFO - 'sessionrestore', 04:42:24 INFO - 'sessionrestore_no_auto_restore']}, 04:42:24 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:42:24 INFO - 'tests': ['a11yr', 04:42:24 INFO - 'ts_paint', 04:42:24 INFO - 'tpaint', 04:42:24 INFO - 'sessionrestore', 04:42:24 INFO - 'sessionrestore_no_auto_restore']}, 04:42:24 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:42:24 INFO - 'tests': ['a11yr', 04:42:24 INFO - 'ts_paint', 04:42:24 INFO - 'tpaint', 04:42:24 INFO - 'sessionrestore', 04:42:24 INFO - 'sessionrestore_no_auto_restore']}, 04:42:24 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:42:24 INFO - 'tests': ['a11yr', 04:42:24 INFO - 'ts_paint', 04:42:24 INFO - 'tpaint', 04:42:24 INFO - 'sessionrestore', 04:42:24 INFO - 'sessionrestore_no_auto_restore']}, 04:42:24 INFO - 'other_l64': {'tests': ['a11yr', 04:42:24 INFO - 'ts_paint', 04:42:24 INFO - 'tpaint', 04:42:24 INFO - 'sessionrestore', 04:42:24 INFO - 'sessionrestore_no_auto_restore']}, 04:42:24 INFO - 'other_nol64': {'tests': ['a11yr', 04:42:24 INFO - 'ts_paint', 04:42:24 INFO - 'tpaint', 04:42:24 INFO - 'sessionrestore', 04:42:24 INFO - 'sessionrestore_no_auto_restore']}, 04:42:24 INFO - 'svgr': {'tests': ['tsvgx', 04:42:24 INFO - 'tsvgr_opacity', 04:42:24 INFO - 'tart', 04:42:24 INFO - 'tscrollx', 04:42:24 INFO - 'cart']}, 04:42:24 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:42:24 INFO - 'tests': ['tsvgx', 04:42:24 INFO - 'tsvgr_opacity', 04:42:24 INFO - 'tart', 04:42:24 INFO - 'tscrollx', 04:42:24 INFO - 'cart']}, 04:42:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:42:24 INFO - 'tests': ['tp5o']}, 04:42:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:42:24 INFO - 'talos_options': ['--e10s'], 04:42:24 INFO - 'tests': ['tp5o']}, 04:42:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:42:24 INFO - 'talos_options': ['--xperf_path', 04:42:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:42:24 INFO - 'tests': ['tp5n']}, 04:42:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:42:24 INFO - 'talos_options': ['--e10s', 04:42:24 INFO - '--xperf_path', 04:42:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:42:24 INFO - 'tests': ['tp5n']}}, 04:42:24 INFO - 'talos.zip': {'path': '', 04:42:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:42:24 INFO - Running post-action listener: _resource_record_post_action 04:42:24 INFO - ##### 04:42:24 INFO - ##### Running create-virtualenv step. 04:42:24 INFO - ##### 04:42:24 INFO - Running pre-action listener: _resource_record_pre_action 04:42:24 INFO - Running main action method: create_virtualenv 04:42:24 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 04:42:24 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 04:42:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 04:42:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:42:24 INFO - Using real prefix '/usr' 04:42:24 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 04:42:25 INFO - Installing distribute.............................................................................................................................................................................................done. 04:42:26 INFO - Installing pip.................done. 04:42:26 INFO - Return code: 0 04:42:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 04:42:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:42:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:42:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:26 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3efd4a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc1d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcec230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7e7f0>, '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 0xcea2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xcea760>, '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': '6d15e502d8e29d5d2676d664000001c3-1453293731.609659-1163643961', '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 04:42:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 04:42:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:42:26 INFO - Using env: {'DISPLAY': ':0', 04:42:26 INFO - 'HOME': '/home/cltbld', 04:42:26 INFO - 'LANG': 'en_US.UTF-8', 04:42:26 INFO - 'LANGUAGE': 'en_US:en', 04:42:26 INFO - 'LOGNAME': 'cltbld', 04:42:26 INFO - 'MAIL': '/var/mail/cltbld', 04:42:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:26 INFO - 'MOZ_NO_REMOTE': '1', 04:42:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:42:26 INFO - 'NO_EM_RESTART': '1', 04:42:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:42:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:42:26 INFO - 'PWD': '/builds/slave/test-pgo', 04:42:26 INFO - 'SHELL': '/bin/bash', 04:42:26 INFO - 'SHLVL': '1', 04:42:26 INFO - 'TERM': 'linux', 04:42:26 INFO - 'TMOUT': '86400', 04:42:26 INFO - 'USER': 'cltbld', 04:42:26 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1453293731.609659-1163643961', 04:42:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:26 INFO - '_': '/tools/buildbot/bin/python'} 04:42:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:27 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 04:42:27 INFO - Cleaning up... 04:42:27 INFO - Return code: 0 04:42:27 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 04:42:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:42:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:42:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:27 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3efd4a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc1d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcec230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7e7f0>, '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 0xcea2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xcea760>, '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': '6d15e502d8e29d5d2676d664000001c3-1453293731.609659-1163643961', '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 04:42:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 04:42:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:42:27 INFO - Using env: {'DISPLAY': ':0', 04:42:27 INFO - 'HOME': '/home/cltbld', 04:42:27 INFO - 'LANG': 'en_US.UTF-8', 04:42:27 INFO - 'LANGUAGE': 'en_US:en', 04:42:27 INFO - 'LOGNAME': 'cltbld', 04:42:27 INFO - 'MAIL': '/var/mail/cltbld', 04:42:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:27 INFO - 'MOZ_NO_REMOTE': '1', 04:42:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:42:27 INFO - 'NO_EM_RESTART': '1', 04:42:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:42:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:42:27 INFO - 'PWD': '/builds/slave/test-pgo', 04:42:27 INFO - 'SHELL': '/bin/bash', 04:42:27 INFO - 'SHLVL': '1', 04:42:27 INFO - 'TERM': 'linux', 04:42:27 INFO - 'TMOUT': '86400', 04:42:27 INFO - 'USER': 'cltbld', 04:42:27 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1453293731.609659-1163643961', 04:42:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:27 INFO - '_': '/tools/buildbot/bin/python'} 04:42:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:27 INFO - Downloading/unpacking psutil>=0.7.1 04:42:27 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 04:42:27 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 04:42:27 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 04:42:27 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 04:42:27 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 04:42:27 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 04:42:29 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 04:42:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:42:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:42:29 INFO - Installing collected packages: psutil 04:42:29 INFO - Running setup.py install for psutil 04:42:29 INFO - building 'psutil._psutil_linux' extension 04:42:29 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 04:42:29 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 04:42:29 INFO - building 'psutil._psutil_posix' extension 04:42:29 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 04:42:29 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 04:42:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:42:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:42:29 INFO - Successfully installed psutil 04:42:29 INFO - Cleaning up... 04:42:29 INFO - Return code: 0 04:42:29 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 04:42:29 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')]} 04:42:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:29 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')]} 04:42:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:29 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3efd4a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc1d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcec230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7e7f0>, '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 0xcea2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xcea760>, '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': '6d15e502d8e29d5d2676d664000001c3-1453293731.609659-1163643961', '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 04:42:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 04:42:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:42:29 INFO - Using env: {'DISPLAY': ':0', 04:42:29 INFO - 'HOME': '/home/cltbld', 04:42:29 INFO - 'LANG': 'en_US.UTF-8', 04:42:29 INFO - 'LANGUAGE': 'en_US:en', 04:42:29 INFO - 'LOGNAME': 'cltbld', 04:42:29 INFO - 'MAIL': '/var/mail/cltbld', 04:42:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:29 INFO - 'MOZ_NO_REMOTE': '1', 04:42:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:42:29 INFO - 'NO_EM_RESTART': '1', 04:42:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:42:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:42:29 INFO - 'PWD': '/builds/slave/test-pgo', 04:42:29 INFO - 'SHELL': '/bin/bash', 04:42:29 INFO - 'SHLVL': '1', 04:42:29 INFO - 'TERM': 'linux', 04:42:29 INFO - 'TMOUT': '86400', 04:42:29 INFO - 'USER': 'cltbld', 04:42:29 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1453293731.609659-1163643961', 04:42:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:29 INFO - '_': '/tools/buildbot/bin/python'} 04:42:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:29 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:42:29 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 04:42:29 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 04:42:29 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 04:42:29 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 04:42:29 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 04:42:29 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 04:42:31 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:42:31 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:42:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:42:31 INFO - Installing collected packages: mozsystemmonitor 04:42:31 INFO - Running setup.py install for mozsystemmonitor 04:42:31 INFO - Successfully installed mozsystemmonitor 04:42:31 INFO - Cleaning up... 04:42:31 INFO - Return code: 0 04:42:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 04:42:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:42:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:42:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:31 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3efd4a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc1d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcec230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7e7f0>, '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 0xcea2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xcea760>, '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': '6d15e502d8e29d5d2676d664000001c3-1453293731.609659-1163643961', '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 04:42:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 04:42:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:42:31 INFO - Using env: {'DISPLAY': ':0', 04:42:31 INFO - 'HOME': '/home/cltbld', 04:42:31 INFO - 'LANG': 'en_US.UTF-8', 04:42:31 INFO - 'LANGUAGE': 'en_US:en', 04:42:31 INFO - 'LOGNAME': 'cltbld', 04:42:31 INFO - 'MAIL': '/var/mail/cltbld', 04:42:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:31 INFO - 'MOZ_NO_REMOTE': '1', 04:42:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:42:31 INFO - 'NO_EM_RESTART': '1', 04:42:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:42:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:42:31 INFO - 'PWD': '/builds/slave/test-pgo', 04:42:31 INFO - 'SHELL': '/bin/bash', 04:42:31 INFO - 'SHLVL': '1', 04:42:31 INFO - 'TERM': 'linux', 04:42:31 INFO - 'TMOUT': '86400', 04:42:31 INFO - 'USER': 'cltbld', 04:42:31 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1453293731.609659-1163643961', 04:42:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:31 INFO - '_': '/tools/buildbot/bin/python'} 04:42:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:32 INFO - Downloading/unpacking blobuploader==1.2.4 04:42:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:33 INFO - Downloading blobuploader-1.2.4.tar.gz 04:42:33 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:42:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:42:33 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 04:42:33 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 04:42:33 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 04:42:33 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 04:42:33 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 04:42:33 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 04:42:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 04:42:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:42:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:34 INFO - Downloading docopt-0.6.1.tar.gz 04:42:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 04:42:34 INFO - Installing collected packages: blobuploader, requests, docopt 04:42:34 INFO - Running setup.py install for blobuploader 04:42:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:42:34 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 04:42:34 INFO - Running setup.py install for requests 04:42:34 INFO - Running setup.py install for docopt 04:42:35 INFO - Successfully installed blobuploader requests docopt 04:42:35 INFO - Cleaning up... 04:42:35 INFO - Return code: 0 04:42:35 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:42:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:42:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:42:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:35 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3efd4a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc1d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcec230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7e7f0>, '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 0xcea2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xcea760>, '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': '6d15e502d8e29d5d2676d664000001c3-1453293731.609659-1163643961', '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 04:42:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 04:42:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:42:35 INFO - Using env: {'DISPLAY': ':0', 04:42:35 INFO - 'HOME': '/home/cltbld', 04:42:35 INFO - 'LANG': 'en_US.UTF-8', 04:42:35 INFO - 'LANGUAGE': 'en_US:en', 04:42:35 INFO - 'LOGNAME': 'cltbld', 04:42:35 INFO - 'MAIL': '/var/mail/cltbld', 04:42:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:35 INFO - 'MOZ_NO_REMOTE': '1', 04:42:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:42:35 INFO - 'NO_EM_RESTART': '1', 04:42:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:42:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:42:35 INFO - 'PWD': '/builds/slave/test-pgo', 04:42:35 INFO - 'SHELL': '/bin/bash', 04:42:35 INFO - 'SHLVL': '1', 04:42:35 INFO - 'TERM': 'linux', 04:42:35 INFO - 'TMOUT': '86400', 04:42:35 INFO - 'USER': 'cltbld', 04:42:35 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1453293731.609659-1163643961', 04:42:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:35 INFO - '_': '/tools/buildbot/bin/python'} 04:42:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:42:35 INFO - Running setup.py (path:/tmp/pip-0kteO9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:42:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:42:35 INFO - Running setup.py (path:/tmp/pip-ykeLHf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:42:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:42:35 INFO - Running setup.py (path:/tmp/pip-QHXr3w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:42:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:42:35 INFO - Running setup.py (path:/tmp/pip-bP5RoP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:42:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:42:35 INFO - Running setup.py (path:/tmp/pip-58ZDZI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:42:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:42:35 INFO - Running setup.py (path:/tmp/pip-srOZLO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:42:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:42:35 INFO - Running setup.py (path:/tmp/pip-n63n6F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:42:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:42:35 INFO - Running setup.py (path:/tmp/pip-84U2fX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:42:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:42:35 INFO - Running setup.py (path:/tmp/pip-XFsnEZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:42:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:42:35 INFO - Running setup.py (path:/tmp/pip-MrFnT7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:42:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:42:36 INFO - Running setup.py (path:/tmp/pip-Xv8_1c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:42:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:42:36 INFO - Running setup.py (path:/tmp/pip-DKdT38-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:42:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:42:36 INFO - Running setup.py (path:/tmp/pip-TSoAfv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:42:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:42:36 INFO - Running setup.py (path:/tmp/pip-TF4UDt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:42:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:42:36 INFO - Running setup.py (path:/tmp/pip-ddoGwj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:42:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:42:36 INFO - Running setup.py (path:/tmp/pip-v2yMVs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:42:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:42:36 INFO - Running setup.py (path:/tmp/pip-cCrYy5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:42:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:42:36 INFO - Running setup.py install for manifestparser 04:42:36 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 04:42:36 INFO - Running setup.py install for mozcrash 04:42:36 INFO - Running setup.py install for mozdebug 04:42:36 INFO - Running setup.py install for mozdevice 04:42:36 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 04:42:36 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 04:42:36 INFO - Running setup.py install for mozfile 04:42:37 INFO - Running setup.py install for mozhttpd 04:42:37 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 04:42:37 INFO - Running setup.py install for mozinfo 04:42:37 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 04:42:37 INFO - Running setup.py install for mozInstall 04:42:37 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 04:42:37 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 04:42:37 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 04:42:37 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 04:42:37 INFO - Running setup.py install for mozleak 04:42:37 INFO - Running setup.py install for mozlog 04:42:37 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 04:42:37 INFO - Running setup.py install for moznetwork 04:42:37 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 04:42:37 INFO - Running setup.py install for mozprocess 04:42:37 INFO - Running setup.py install for mozprofile 04:42:37 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 04:42:37 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 04:42:37 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 04:42:37 INFO - Running setup.py install for mozrunner 04:42:38 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 04:42:38 INFO - Running setup.py install for mozscreenshot 04:42:38 INFO - Running setup.py install for moztest 04:42:38 INFO - Running setup.py install for mozversion 04:42:38 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 04:42:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:42:38 INFO - Cleaning up... 04:42:38 INFO - Return code: 0 04:42:38 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:42:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:42:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:42:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:38 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3efd4a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc1d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcec230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7e7f0>, '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 0xcea2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xcea760>, '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': '6d15e502d8e29d5d2676d664000001c3-1453293731.609659-1163643961', '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 04:42:38 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 04:42:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:42:38 INFO - Using env: {'DISPLAY': ':0', 04:42:38 INFO - 'HOME': '/home/cltbld', 04:42:38 INFO - 'LANG': 'en_US.UTF-8', 04:42:38 INFO - 'LANGUAGE': 'en_US:en', 04:42:38 INFO - 'LOGNAME': 'cltbld', 04:42:38 INFO - 'MAIL': '/var/mail/cltbld', 04:42:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:38 INFO - 'MOZ_NO_REMOTE': '1', 04:42:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:42:38 INFO - 'NO_EM_RESTART': '1', 04:42:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:42:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:42:38 INFO - 'PWD': '/builds/slave/test-pgo', 04:42:38 INFO - 'SHELL': '/bin/bash', 04:42:38 INFO - 'SHLVL': '1', 04:42:38 INFO - 'TERM': 'linux', 04:42:38 INFO - 'TMOUT': '86400', 04:42:38 INFO - 'USER': 'cltbld', 04:42:38 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1453293731.609659-1163643961', 04:42:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:38 INFO - '_': '/tools/buildbot/bin/python'} 04:42:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:42:38 INFO - Running setup.py (path:/tmp/pip-Q8meKZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:42:38 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)) 04:42:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:42:38 INFO - Running setup.py (path:/tmp/pip-TEjZTP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:42:38 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)) 04:42:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:42:38 INFO - Running setup.py (path:/tmp/pip-pUqwRK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:42:38 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)) 04:42:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:42:38 INFO - Running setup.py (path:/tmp/pip-CxrNbd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:42:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 04:42:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:42:38 INFO - Running setup.py (path:/tmp/pip-hrl2lf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:42:38 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)) 04:42:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:42:38 INFO - Running setup.py (path:/tmp/pip-rPZAbP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:42:38 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)) 04:42:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:42:38 INFO - Running setup.py (path:/tmp/pip-lGAeV8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:42:39 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)) 04:42:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:42:39 INFO - Running setup.py (path:/tmp/pip-Wscnmu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:42:39 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)) 04:42:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:42:39 INFO - Running setup.py (path:/tmp/pip-_KYPMD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:42:39 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)) 04:42:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:42:39 INFO - Running setup.py (path:/tmp/pip-WRLP2H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:42:39 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)) 04:42:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:42:39 INFO - Running setup.py (path:/tmp/pip-MQOrzU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:42:39 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)) 04:42:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:42:39 INFO - Running setup.py (path:/tmp/pip-B3hzPD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:42:39 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)) 04:42:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:42:39 INFO - Running setup.py (path:/tmp/pip-OLoYQr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:42:39 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)) 04:42:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:42:39 INFO - Running setup.py (path:/tmp/pip-g0_1i_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:42:39 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)) 04:42:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:42:39 INFO - Running setup.py (path:/tmp/pip-cTQ738-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:42:39 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)) 04:42:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:42:39 INFO - Running setup.py (path:/tmp/pip-hHf3zp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:42:39 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)) 04:42:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:42:39 INFO - Running setup.py (path:/tmp/pip-G7823K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:42:39 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)) 04:42:39 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)) 04:42:39 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)) 04:42:39 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)) 04:42:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 04:42:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 04:42:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 04:42:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:41 INFO - Downloading blessings-1.5.1.tar.gz 04:42:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 04:42:41 INFO - Installing collected packages: blessings 04:42:41 INFO - Running setup.py install for blessings 04:42:41 INFO - Successfully installed blessings 04:42:41 INFO - Cleaning up... 04:42:41 INFO - Return code: 0 04:42:41 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 04:42:41 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:42:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:42:41 INFO - Reading from file tmpfile_stdout 04:42:41 INFO - Current package versions: 04:42:41 INFO - argparse == 1.2.1 04:42:41 INFO - blessings == 1.5.1 04:42:41 INFO - blobuploader == 1.2.4 04:42:41 INFO - docopt == 0.6.1 04:42:41 INFO - manifestparser == 1.1 04:42:41 INFO - mozInstall == 1.12 04:42:41 INFO - mozcrash == 0.16 04:42:41 INFO - mozdebug == 0.1 04:42:41 INFO - mozdevice == 0.48 04:42:41 INFO - mozfile == 1.2 04:42:41 INFO - mozhttpd == 0.7 04:42:41 INFO - mozinfo == 0.9 04:42:41 INFO - mozleak == 0.1 04:42:41 INFO - mozlog == 3.1 04:42:41 INFO - moznetwork == 0.27 04:42:41 INFO - mozprocess == 0.22 04:42:41 INFO - mozprofile == 0.28 04:42:41 INFO - mozrunner == 6.11 04:42:41 INFO - mozscreenshot == 0.1 04:42:41 INFO - mozsystemmonitor == 0.0 04:42:41 INFO - moztest == 0.7 04:42:41 INFO - mozversion == 1.4 04:42:41 INFO - psutil == 3.1.1 04:42:41 INFO - requests == 1.2.3 04:42:41 INFO - wsgiref == 0.1.2 04:42:41 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:42:41 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')]} 04:42:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:41 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')]} 04:42:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:41 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3efd4a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc1d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcec230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7e7f0>, '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 0xcea2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xcea760>, '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': '6d15e502d8e29d5d2676d664000001c3-1453293731.609659-1163643961', '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 04:42:41 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 04:42:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:42:41 INFO - Using env: {'DISPLAY': ':0', 04:42:41 INFO - 'HOME': '/home/cltbld', 04:42:41 INFO - 'LANG': 'en_US.UTF-8', 04:42:41 INFO - 'LANGUAGE': 'en_US:en', 04:42:41 INFO - 'LOGNAME': 'cltbld', 04:42:41 INFO - 'MAIL': '/var/mail/cltbld', 04:42:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:41 INFO - 'MOZ_NO_REMOTE': '1', 04:42:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:42:41 INFO - 'NO_EM_RESTART': '1', 04:42:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:42:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:42:41 INFO - 'PWD': '/builds/slave/test-pgo', 04:42:41 INFO - 'SHELL': '/bin/bash', 04:42:41 INFO - 'SHLVL': '1', 04:42:41 INFO - 'TERM': 'linux', 04:42:41 INFO - 'TMOUT': '86400', 04:42:41 INFO - 'USER': 'cltbld', 04:42:41 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1453293731.609659-1163643961', 04:42:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:41 INFO - '_': '/tools/buildbot/bin/python'} 04:42:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:42 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)) 04:42:42 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)) 04:42:42 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)) 04:42:42 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)) 04:42:42 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)) 04:42:42 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)) 04:42:42 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)) 04:42:42 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)) 04:42:42 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)) 04:42:42 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)) 04:42:42 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)) 04:42:42 INFO - Cleaning up... 04:42:42 INFO - Return code: 0 04:42:42 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 04:42:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:42:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:42:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:42 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3efd4a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc1d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcec230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7e7f0>, '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 0xcea2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xcea760>, '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': '6d15e502d8e29d5d2676d664000001c3-1453293731.609659-1163643961', '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 04:42:42 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 04:42:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:42:42 INFO - Using env: {'DISPLAY': ':0', 04:42:42 INFO - 'HOME': '/home/cltbld', 04:42:42 INFO - 'LANG': 'en_US.UTF-8', 04:42:42 INFO - 'LANGUAGE': 'en_US:en', 04:42:42 INFO - 'LOGNAME': 'cltbld', 04:42:42 INFO - 'MAIL': '/var/mail/cltbld', 04:42:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:42 INFO - 'MOZ_NO_REMOTE': '1', 04:42:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:42:42 INFO - 'NO_EM_RESTART': '1', 04:42:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:42:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:42:42 INFO - 'PWD': '/builds/slave/test-pgo', 04:42:42 INFO - 'SHELL': '/bin/bash', 04:42:42 INFO - 'SHLVL': '1', 04:42:42 INFO - 'TERM': 'linux', 04:42:42 INFO - 'TMOUT': '86400', 04:42:42 INFO - 'USER': 'cltbld', 04:42:42 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1453293731.609659-1163643961', 04:42:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:42 INFO - '_': '/tools/buildbot/bin/python'} 04:42:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:42 INFO - Downloading/unpacking jsonschema 04:42:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:42:44 INFO - Downloading/unpacking functools32 (from jsonschema) 04:42:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:44 INFO - Downloading functools32-3.2.3-2.tar.gz 04:42:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 04:42:44 INFO - warning: no files found matching '*.txt' 04:42:44 INFO - no previously-included directories found matching 'build' 04:42:44 INFO - no previously-included directories found matching 'dist' 04:42:44 INFO - no previously-included directories found matching '.git*' 04:42:44 INFO - Installing collected packages: jsonschema, functools32 04:42:44 INFO - Running setup.py install for functools32 04:42:44 INFO - warning: no files found matching '*.txt' 04:42:44 INFO - no previously-included directories found matching 'build' 04:42:44 INFO - no previously-included directories found matching 'dist' 04:42:44 INFO - no previously-included directories found matching '.git*' 04:42:44 INFO - Successfully installed jsonschema functools32 04:42:44 INFO - Cleaning up... 04:42:44 INFO - Return code: 0 04:42:44 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 04:42:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:42:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:42:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:44 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3efd4a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc1d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcec230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7e7f0>, '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 0xcea2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xcea760>, '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': '6d15e502d8e29d5d2676d664000001c3-1453293731.609659-1163643961', '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 04:42:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 04:42:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:42:44 INFO - Using env: {'DISPLAY': ':0', 04:42:44 INFO - 'HOME': '/home/cltbld', 04:42:44 INFO - 'LANG': 'en_US.UTF-8', 04:42:44 INFO - 'LANGUAGE': 'en_US:en', 04:42:44 INFO - 'LOGNAME': 'cltbld', 04:42:44 INFO - 'MAIL': '/var/mail/cltbld', 04:42:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:44 INFO - 'MOZ_NO_REMOTE': '1', 04:42:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:42:44 INFO - 'NO_EM_RESTART': '1', 04:42:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:42:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:42:44 INFO - 'PWD': '/builds/slave/test-pgo', 04:42:44 INFO - 'SHELL': '/bin/bash', 04:42:44 INFO - 'SHLVL': '1', 04:42:44 INFO - 'TERM': 'linux', 04:42:44 INFO - 'TMOUT': '86400', 04:42:44 INFO - 'USER': 'cltbld', 04:42:44 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1453293731.609659-1163643961', 04:42:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:44 INFO - '_': '/tools/buildbot/bin/python'} 04:42:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:44 INFO - Downloading/unpacking flake8 04:42:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:46 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:42:46 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:42:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:46 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:42:46 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:42:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:47 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:42:47 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 04:42:47 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 04:42:47 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 04:42:47 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 04:42:47 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 04:42:47 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 04:42:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 04:42:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:42:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:42:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:42:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:42:47 INFO - no previously-included directories found matching 'docs/_build' 04:42:47 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:42:47 INFO - Running setup.py install for pep8 04:42:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:42:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:42:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:42:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:42:47 INFO - no previously-included directories found matching 'docs/_build' 04:42:47 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 04:42:47 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:42:47 INFO - Cleaning up... 04:42:47 INFO - Return code: 0 04:42:47 INFO - Running post-action listener: _resource_record_post_action 04:42:47 INFO - Running post-action listener: _start_resource_monitoring 04:42:47 INFO - Starting resource monitoring. 04:42:47 INFO - ##### 04:42:47 INFO - ##### Running install step. 04:42:47 INFO - ##### 04:42:47 INFO - Running pre-action listener: _resource_record_pre_action 04:42:47 INFO - Running main action method: install 04:42:47 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:42:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:42:47 INFO - Reading from file tmpfile_stdout 04:42:47 INFO - Detecting whether we're running mozinstall >=1.0... 04:42:47 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 04:42:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 04:42:47 INFO - Reading from file tmpfile_stdout 04:42:47 INFO - Output received: 04:42:47 INFO - Usage: mozinstall [options] installer 04:42:47 INFO - Options: 04:42:47 INFO - -h, --help show this help message and exit 04:42:47 INFO - -d DEST, --destination=DEST 04:42:47 INFO - Directory to install application into. [default: 04:42:47 INFO - "/builds/slave/test-pgo"] 04:42:47 INFO - --app=APP Application being installed. [default: firefox] 04:42:47 INFO - mkdir: /builds/slave/test-pgo/build/application 04:42:47 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'] 04:42:47 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 04:43:03 INFO - Reading from file tmpfile_stdout 04:43:03 INFO - Output received: 04:43:03 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 04:43:03 INFO - Running post-action listener: _resource_record_post_action 04:43:03 INFO - ##### 04:43:03 INFO - ##### Running run-tests step. 04:43:03 INFO - ##### 04:43:03 INFO - Running pre-action listener: _resource_record_pre_action 04:43:03 INFO - Running main action method: run_tests 04:43:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 04:43:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 04:43:03 INFO - Python 2.7.3 04:43:03 INFO - Return code: 0 04:43:03 INFO - grabbing minidump binary from tooltool 04:43:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:43:03 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 0xd7e7f0>, '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 0xcea2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xcea760>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 04:43:03 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 04:43:03 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 04:43:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:43:04 INFO - Return code: 0 04:43:04 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 04:43:04 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 04:43:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 04:43:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 04:43:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 04:43:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 04:43:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 04:43:04 INFO - Return code: 0 04:43:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aSnZ95h1Qcei6o3qrDDWCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 04:43:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/aSnZ95h1Qcei6o3qrDDWCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --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 04:43:04 INFO - Using env: {'DISPLAY': ':0', 04:43:04 INFO - 'HOME': '/home/cltbld', 04:43:04 INFO - 'LANG': 'en_US.UTF-8', 04:43:04 INFO - 'LANGUAGE': 'en_US:en', 04:43:04 INFO - 'LOGNAME': 'cltbld', 04:43:04 INFO - 'MAIL': '/var/mail/cltbld', 04:43:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:43:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 04:43:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:04 INFO - 'MOZ_NO_REMOTE': '1', 04:43:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:43:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:43:04 INFO - 'NO_EM_RESTART': '1', 04:43:04 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:43:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:43:04 INFO - 'PWD': '/builds/slave/test-pgo', 04:43:04 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 04:43:04 INFO - 'SHELL': '/bin/bash', 04:43:04 INFO - 'SHLVL': '1', 04:43:04 INFO - 'TERM': 'linux', 04:43:04 INFO - 'TMOUT': '86400', 04:43:04 INFO - 'USER': 'cltbld', 04:43:04 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1453293731.609659-1163643961', 04:43:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:04 INFO - '_': '/tools/buildbot/bin/python'} 04:43:04 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aSnZ95h1Qcei6o3qrDDWCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 04:43:05 INFO - mozversion application_buildid: 20160120013040 04:43:05 INFO - mozversion application_changeset: 39f56e62c694ea209ab0013a4c357084e7ed67ce 04:43:05 INFO - mozversion application_display_name: Nightly 04:43:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:43:05 INFO - mozversion application_name: Firefox 04:43:05 INFO - mozversion application_remotingname: firefox 04:43:05 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:43:05 INFO - mozversion application_vendor: Mozilla 04:43:05 INFO - mozversion application_version: 46.0a1 04:43:05 INFO - mozversion platform_buildid: 20160120013040 04:43:05 INFO - mozversion platform_changeset: 39f56e62c694ea209ab0013a4c357084e7ed67ce 04:43:05 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:43:05 INFO - mozversion platform_version: 46.0a1 04:43:05 INFO - using testdate: 1453293785 04:43:05 INFO - actual date: 1453293785 04:43:05 INFO - starting webserver on 'localhost:60821' 04:43:05 INFO - SUITE-START | Running 3 tests 04:43:05 INFO - TEST-START | dromaeo_css 04:43:05 INFO - operating with platform_type : linux_ 04:43:05 INFO - Initialising browser for dromaeo_css test... 04:43:05 INFO - TEST-INFO | started process 23124 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9ddKAm/profile http://localhost:60821/getInfo.html) 04:43:09 INFO - PROCESS | 23124 | __metrics Screen width/height:1600/1200 04:43:09 INFO - PROCESS | 23124 | colorDepth:24 04:43:09 INFO - PROCESS | 23124 | Browser inner width/height: 1024/697 04:43:09 INFO - PROCESS | 23124 | __metrics 04:43:09 INFO - PROCESS | 23124 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:43:09 INFO - PROCESS | 23124 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:43:10 INFO - TEST-INFO | 23124: exit 0 04:43:10 INFO - Browser initialized. 04:43:10 INFO - Running cycle 1/1 for dromaeo_css test... 04:43:10 INFO - TEST-INFO | started process 23218 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9ddKAm/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:43:22 INFO - PROCESS | 23218 | RSS: Main: 148733952 04:43:22 INFO - PROCESS | 23218 | 04:44:13 INFO - PROCESS | 23218 | 1453293853653 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] 04:46:21 INFO - PROCESS | 23218 | Cycle 1(1): loaded http://localhost:60821/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60821/tests/dromaeo/cssquery-ext.html) 04:46:22 INFO - PROCESS | 23218 | RSS: Main: 276803584 04:46:22 INFO - PROCESS | 23218 | 04:49:25 INFO - PROCESS | 23218 | Cycle 1(1): loaded http://localhost:60821/tests/dromaeo/cssquery-ext.html (next: http://localhost:60821/tests/dromaeo/cssquery-jquery.html) 04:49:25 INFO - PROCESS | 23218 | RSS: Main: 232886272 04:49:25 INFO - PROCESS | 23218 | 04:52:28 INFO - PROCESS | 23218 | Cycle 1(1): loaded http://localhost:60821/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60821/tests/dromaeo/cssquery-mootools.html) 04:52:28 INFO - PROCESS | 23218 | RSS: Main: 228687872 04:52:28 INFO - PROCESS | 23218 | 04:55:30 INFO - PROCESS | 23218 | Cycle 1(1): loaded http://localhost:60821/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60821/tests/dromaeo/cssquery-prototype.html) 04:55:31 INFO - PROCESS | 23218 | RSS: Main: 209788928 04:55:31 INFO - PROCESS | 23218 | 04:58:33 INFO - PROCESS | 23218 | Cycle 1(1): loaded http://localhost:60821/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60821/tests/dromaeo/cssquery-yui.html) 04:58:34 INFO - PROCESS | 23218 | RSS: Main: 214798336 04:58:34 INFO - PROCESS | 23218 | 05:01:36 INFO - PROCESS | 23218 | Cycle 1(1): loaded http://localhost:60821/tests/dromaeo/cssquery-yui.html (next: http://localhost:60821/tests/dromaeo/cssquery-dojo.html) 05:01:37 INFO - PROCESS | 23218 | RSS: Main: 257777664 05:01:37 INFO - PROCESS | 23218 | 05:01:37 INFO - PROCESS | 23218 | __start_tp_report 05:01:37 INFO - PROCESS | 23218 | _x_x_mozilla_page_load 05:01:37 INFO - PROCESS | 23218 | _x_x_mozilla_page_load_details 05:01:37 INFO - PROCESS | 23218 | |i|pagename|runs| 05:01:37 INFO - PROCESS | 23218 | |0;dojo.html;3125.7655675824317;3153.826539540326;3202.7758056936023;3209.5827542419497;3234.175285302248;4964;5039.5716364109;5096.082705113083;5096.745162741862;5170.172772356424;5049.4193167785625;5089.974550127254;5098.107831129547;5100.795968161278;5160.612954028444;4654.999175177336;4681.180793361165;4688.390509233795;4736.763161841911;4790.66465347424;4721.527847215269;4738.763061846894;4765.189917713979;4789.066132104241;4802.135615589193;4592.862214133581;4619.722816631013;4673.415823022122;4674.392328997243;4694.155052090622;4610.953890461086;4624.491305956342;4630.513796051433;4632.3051542268595;4667;4525.32120181972;4605.746683932382;4611.262198048296;4621.792019359137;4654.720716757005;4907.803687852517;4914.827981020647;4929.704217746947;4955.82654607087;4981.900361992776;5520.1167813149705;5534.252875861747;5535.529479994206;5541.750621222014;5546.223528705985;5441.700706461143;5555.972220138873;5568.52667523261;5602.215689803431;5622.887542249173;5126.333576635014;5151.381834179922;5152.58779297659;5156.535911767922;5170.482951704837;5610;5634.97182514093;5638.830835074954;5641.351244606841;5651.406602306781;5284.180951952453;5359.705216213068;5401.783928642811;5419.0245755764345;5423.267858839085;5495.450454954473;5530.198121272473;5533.667979921218;5536.058869992031;5582.581306402036;5454;5470.343558772973;5473.644213126214;5480.808171713971;5521.033819081645;5377.166539186354;5408.0535906216255;5454.972725136428;5531.751071201806;5564.860878478071;4250.702450828412;4283.935740963888;4291.485021797404;4320.740755554677;4321.956780432155;3799.069228039148;3809.9047523811573;3829.5021647185686;3858.5369755629504;3859.864904728321;5045.369328833895;5065.366829146356;5072;5099.107656160157;5145.76844042019;5517.227588137664;5537.058700021006;5543.833684989457;5548.55611551075;5561.026820306431;5154.098032844312;5165.9225111623355;5168.715720635401;5171.120909445403;5210.7915683373;4637.536246375403;4719.244920812654;4739.454962679267;4753.904921901542;4815.855524334275;5671.631343962629;5694.1458781183155;5703.344115426696;5703.914441283384;5704.572157088235;5488.807891723771;5488.835334939959;5492.313460817398;5492.972535137299;5545.473180047889;5689.630174038674;5742.827715168552;5769.451902069297;5780.913286300793;5808.477237048686;5383;5386.165144402624;5390.00284947286;5391;5397.244385786072;5398.568114550905;5445.727713614224;5450.5367043801725;5451.809186678447;5491.313585801775;5265.973670131625;5315.946840531546;5339.199120132012;5394.919076213781;5410.756515956713;5280.155175171954;5293.920591191212;5296.390915044665;5298.470152984671;5300.284461597635;5213.061648903234;5213.947860521346;5218.947810521846;5221.451747566451;5270.077736396039;5285.841424757264;5318.202269659582;5338.225957236256;5410.242566040679;5414.593905457185;5267.525922666979;5279.9472005280995;5279.973600132128;5318.335208098988;5329.840104796862 05:01:37 INFO - PROCESS | 23218 | |1;ext.html;521.2936471081684;522.0889547739196;545.9590530710193;558.5782734035803;582.1471544187765;29022.129336119924;29404.705952940465;29437.2640683983;29438.11685649431;29463.410731785352;37124.81437592808;37224.81387593058;37443.251134977356;37465.06337341561;37501.81249093758;8650.826983460327;8894.37739358242;8894.644214231455;8896.777580560472;8905.020447750774;8623.611937462798;8759.255463285628;8763.605637746285;8771.16673915977;8778.122187781202;8730.781730456725;8859.77850553738;8899.644014239422;8900.955495222515;8915.821683566324;8731;8775.16635919593;8803.20771130595;8815.118488151198;8823;8590.699325523577;8666.86999695005;8689.348298877547;8728.083551227093;8729.170728780819;36709.81645091758;36901;36993.26013479715;39444;39445;3216.163797412666;3218.5024252723993;3658.487811706363;3773.9998900291444;4104.507459104897;30281.697183028107;30409.69590304091;30536.236594085105;30954.0713778587;31492.37015259705;3422.212891035051;3436.484527320897;3514.0863375522295;3533.717302615785;3581.7313701472494;263600;264387;265032;265268;265624;53704;54005.45994540083;59546.70226648839;59980.400195997485;60623.393766062654;55359.723201383735;55807;56110.43889561134;56119;56146.9119198448;14739.410423582936;15026.098434093989;15032.248387580577;15053.096814191184;15067.397304107932;11048.226624136234;11407.201495895373;11424.257423267461;11514.596989105508;12118.212316199419;19569.608607827762;19637.410877673694;19684.70472942907;19691.60616787656;19776.505587360432;7400.111986561647;7560.508566943131;7571.848563028709;7624.656890439833;7732.458727889106;967.5162418790604;1020.8723909511311;1029.629333439961;1049.742813010802;1097.4128841070149;29223.415531689247;29374.853125734233;29486;30168.24579385533;30669.386612268077;1031.0720351683394;1049.5801679328176;1066.823974044274;1069.3102948598112;1072.2922870905165;13544.187348759106;15720;15788.368465261261;16499.85317758536;16688.165591720608;309432;311231;312423;312557;312907;51403.7429812856;52871.20693189605;53019;53123;53177.202341964905;1220.6155061155885;1273.5860845225154;1330.3348325837276;1365.9726805464034;1367.883729882971;25657.61513577335;26397.875229651207;26801.329966750985;26817.329566760985;26874;38574.61425385823;38830.2233955325;38987.22025559416;38993.80503097466;43659;184131;413636;421713;422281;423018;30636.540451893685;31269.8436507816;31339.843300783352;31359;31434.68565314409;43032.13935721206;43250.134997300505;44235.55764442314;44406.11187776162;44457.10971793165;31970;32363;32472.675273246965;32639.419973183503;32654.836725816218;35186.12034699051;35241.118972025906;35474;35566.288674225856;35719.28561428705;34964.47553286652;35455.29089418145;35734.64265357313;35748.821255893556;35781;31148.68851311458;31998.68001319957;32596.83701581477;32609.673903260664;32623.34753304968;23990.45374660483;24687.753122468544;24712.258632240344;25069.247922562354;25168.24495265145 05:01:37 INFO - PROCESS | 23218 | |2;jquery.html;345.9117924929144;346.95836499620043;347.37125802297845;349.15504479160427;358.4372535119863;13694.93152534236;14126.43494260231;15625.531234062983;16398.26207820648;18188.818111818877;15670.216489175524;15826.208689565534;17041.403550875722;17206.56983575411;17223.91388043058;5084.13569693153;5379.462053794608;5387.78448862045;5390.1914712793005;5390.487903649167;3957.0700885291935;4071.6131967463193;5261.868453288679;5513;5736.827895163152;5087.211482220262;5619.4942455179025;5668.404817494165;5693.117566777156;5695.202671625976;5213.218017297436;5214.348206474191;5222.060029194743;5246.344206974129;5248.02911461379;5026.924596131061;5251.369835619712;5259.552938000236;5263.131583288753;5274.604404669627;11870.465829037628;19367.225310987542;19811.80188198114;19883.602327953504;20093.196272149242;1974.9802501975084;2097.8321734261376;2136.9893150534303;2148.387709502784;2160.3734916874087;8770.605322760492;9340.439573625536;9369.76575585609;10942.960418760205;11225.494852731646;1720.750491178772;1809.3938530592268;1815.954601134969;1816.4459839748872;1829.1128802530761;54351.72824135854;56474.71762641201;56764.71617641886;58024;58305.416945830846;9793.118619324296;9881.604735810488;9913.900860991442;9936.552855121392;9980.101790838859;12973.09188356806;13120.737585248433;13134.802977955338;13143.474261029452;13153.21080735159;7207.531510451804;7292.963535182396;7299.05112335393;7415.555066696015;7450.292222238879;6983.8603227935155;7046.295370462913;7057.258987806206;7077.433805295564;7126.643667816588;4021.477207962946;4310.741355518616;4379.605835474823;4406.911861762746;4434;1707.4706840879367;1758.87687861851;1833.6791061564172;1834.1837882142318;1851.8518518518486;908.5638893331238;934.289939645874;939.6523286384082;1044.4151275285712;1061.2836335473678;14285;15134.318955647022;15900.76148857768;16066.43767468133;16956.321747130223;927.9396839205565;934.7382732834817;960.6349587156975;968.3995922528078;1006.3911333643186;9390.85913711295;9581.425114493153;9914.40513569188;9991.850122248172;10203.897961020442;487440;496697;539240;547338;571820;56878.43121568731;73664.26335736681;73901.6304918472;73981.63009184919;75709;1174.94712737927;1175.3359351966283;1209.9455524501418;1226.0314351662266;1248.6441364211157;15124.54626361211;15241.314140863466;15381.923090384476;15458.304376303318;15684.764728528853;33193.17017074592;33251.50122748209;33423.83288083544;33645.66354336425;33990;42838;44506;45081;47946.76026619845;48000.519994801005;6880.759173428906;7076.018180197745;7078.115235595551;7275.090613673291;7439.070116235471;10840.970107839743;10962.945185274342;11295.830562541403;11419.714507137389;11546.94226528862;9238.722838314861;9239.72280831576;9554.808903821746;9629.422234665943;9712.660056897974;9487.905120948702;9530.428174309563;9583.760405989628;10095.545700443645;10123.797524049625;9845.523171524328;9962.452065136487;10015.449150296803;10060.849087263843;10084.596616135566;7220.675069621774;7411.295926886937;7429.4799364044;7442.590657513889;7470.6264686766535;6706.329367063255;9117.225035872025;9156;10151.086402223835;10157.39055656663 05:01:37 INFO - PROCESS | 23218 | |3;mootools.html;1325.039346473806;1473.4474572035488;1474.2333986327114;1632.5836911587544;1791.2118667786174;6915.861682766348;7481.02746642937;7663.386929045677;7691.192424795386;7694.345980591656;7606.163322034586;7784.299413052824;7790.688372465109;7793.181715919818;7793.415493837956;2001.2095222387147;2047.4164863014043;2050.8769473831617;2279.954400911985;2312.144506532585;2065.6901464780326;2267.127156044918;2304.331743794298;2328.1967721136266;2332.370260029791;2214.9224777132804;2256.1539422716482;2264.53577016712;2290.896909639062;2293.2317673579373;2211.2592281585526;2235.564065007324;2242.416971587391;2245.8989345479495;2266.161520237506;2281.1217681192693;2295.8163346932206;2297.184499502669;2299.528596637685;2313.641385585237;7528.47300688952;7621.704310267268;7626.046744156981;7626.313631773111;7629.618519074024;4749.57253847152;4842.903141937141;4856.854294371175;4873.951260487385;4887.242477416006;3150.3069324748517;3209.293955329824;3244.3024749678934;3246.3020450603235;3247.6589958054537;1121.9551217951355;1128.328644456547;1130.4912789244872;1132.9603463878725;1224.5163160551533;10600;10616.946915265375;10637.414942178177;10661.147108231324;10671;4311.202427550913;4385.51759306476;4427.8228870844805;4430.18041662287;4474.530174331713;9252.95373523128;9262.30532710036;9263.351565390492;9265.166135047879;9267.165955064076;4859.101066302675;4871.171900776805;4897.583705385011;4900.460949295574;4903.828366007173;4406.757628330409;4410.779461026936;4461.643068554507;4466.285394336891;4466.419365482531;3538.7699799512948;3619.2037751694584;3756.0985363513105;3840.1743625120175;3869.187470631143;1214.8420705308254;1216.3796463803524;1249.9625011249677;1251.5119103549623;1252.2048499203072;1319.7492476429447;1342.5502456677123;1348.8651134886434;1354.3634491788844;1362.1350442468906;7120.465965052538;7422.257774222642;7602.46782725204;7609.6575654095695;7612.543247405173;1093.9179561532917;1113.4599719136374;1129.5764088466824;1130.496928866663;1142.493815631311;5912.17229587858;5954.910676339771;6004.219451471281;6005.069214271794;6012;8868.11318868108;8894.555272236363;8976.685815996409;8979.46123232608;9117;8926.553672316359;9017.233535149455;9034.503102329303;9035.412698174729;9036.63853445868;7055.729968605598;7080.221175670672;7209.206987231505;7238.167610724729;7241.710331586783;7225.169105552718;7273.709051637875;7351.301626345488;7358.66885990121;7359.742409015659;8364.707235246737;8386.622601983048;8595.570221488775;8724.345674074597;8745.606447709995;8668.219860212612;8771.605277762388;8771.824563508566;8916.28669706409;8921.643134274556;7120.0743903294315;7193.712251509881;7219.819504512429;7222.349988501061;7229.566226026455;6599.505037122139;6785.558938668971;7167.139943206848;7473.476856619985;7552.66013029426;7002.2297547268745;7038.40173585251;7081.18566364854;7119.252478489684;7388.889166662612;7023.33278338557;7091.184513780775;7113.53762005468;7187.209406965334;7215.567065976058;7187.101612298463;7196.136463624399;7223.061002069908;7231.204567497676;7263.0921134858145;6430;6579.440747536513;6585.308542603149;6587.209534855848;6648;6607.9669601651685;6652.467802575879;6658.400743933069;6664.133662623828;6675.165604299463 05:01:37 INFO - PROCESS | 23218 | |4;prototype.html;329.5567461763928;331.3968577189515;337.7433150805389;347.4718427989458;352.5223322398152;5628.718564071801;5756.107803290486;5772.682502462373;5790.33411157717;5798.0433228517295;5536.695481748502;5675.943240567593;5684.346300175481;5687.289088863892;5739.770409183638;4480.887977800565;4483.148201841656;4484.97757511212;4488.640908727294;4495.9325610115875;4316.503602085753;4378.299472084467;4390.714603550759;4474.284114541674;4490.281554951209;4411.382406463098;4427.756473393962;4436.600705936465;4438.112377524491;4440.955590444103;4425.269830477967;4435.556444355571;4442.888927776815;4444.622207112399;4453.265211240141;3910.491636087319;3910.511186101737;3918.1380096378753;3920.6863450923856;3922.235164142993;5363.54409875161;5489.64317319373;5491.752871120769;5499.642523236017;5509.393966663663;5106.744662766847;5110.310108135429;5114.181730923072;5115.693058416469;5118.155504341779;6046.667433291167;6049.909251361233;6056.697165141725;6060.727267272983;6061.66660833654;4151.97924010381;4290.442242508485;4291.24903141952;4293.935590966138;4303.8063287151845;6030.698465076729;6330.936690633081;6408.03879418091;6417.294097649255;6427.967860160716;4378.78106094694;4393.209222339946;4401.515833258339;4402.713823601455;4407.382966384709;4454.933176002362;4457.064016556495;4463.174312752151;4464.30803225494;4470.195364834296;5017.924731128963;5108.182690769459;5110.7955681773055;5115.769790359443;5119.718415487109;6156.722947467375;6157.476614487819;6159.969200153971;6163.167972323679;6164.352742962014;1568.741157708988;1572.709048825971;1578.3449868304754;1578.3923189571867;1579.3287852662572;1067.8077945969644;1081.1891081688734;1081.6538707613645;1086.5545126498098;1086.706589220906;5827.883442331215;5832.154337621021;5840.211571437886;5852.297724273115;5857.443542863506;6307.873842523124;6311.33730958252;6321.051842223703;6322.683865806691;6324.71538780756;5812.099124635688;5832.358440571534;5836.358000619928;5840.707964601753;5849.88300233993;3255.4628486299493;3389.5424117743787;3393.6436674149354;3394.287199688044;3394.4229480988292;6556.836079097965;6564.4420224281475;6570.967145164243;6577.21073471177;6596.373344532261;6406.23125224976;6454.774082907075;6456.289808121103;6456.870862582722;6471.611703297817;6471.288158302583;6559.573627714279;6615.801525954229;6624.668766561749;6639.601623902485;6269.185005949197;6330.8733825322315;6332.11350410952;6336.271328797247;6338.749743841055;6071.7571297147615;6186.4741496973265;6251.624902505864;6275.623462592259;6283;6453.741850325934;6591.176102987127;6616.933830661632;6630.801075967729;6633.535652504278;4315.892102697458;4339.522652508158;4342.478902531717;4347.369631403492;4348.652107831429;6189.907151392643;6316.05259211122;6318;6336.683165841781;6338.524610654127;6166.969165154145;6172.660503672341;6182.7217775201125;6183.84540386494;6187.783427580013;6161.353057928853;6161.383861613803;6162.630242185483;6164.137020817179;6175.042868355412;5945.494632956247;6067.726952287069;6070.726817293321;6070.757169713162;6081.148639190428;6169.81490555284;6195.4424101831055;6198.318184999556;6199.225096862892;6209.503239740719;5991.970040149771;6012.368701286477;6016.548758843017;6017.939820601738;6020.247469066367 05:01:37 INFO - PROCESS | 23218 | |5;yui.html;770.7610640701383;842.4187310755582;849.1126772522717;861.969831055913;863.8747381629668;13020.739585208303;13276.535321263758;13351.332433378317;13356.198628082322;13397.799033014513;11923.344216068113;12384.690382740437;12468.563600273992;12520.18618789778;12546.059045571574;665.7403612591081;798.4929569723209;811.0308181722844;814.7433558429105;815.1074573342181;791.7070683846985;793.8610743119959;794.2772077409559;796.4584082823677;799.7760627024413;692.8025512728873;844.4300097434239;845.3110714767445;848.3001523742937;849.2526576612603;697.3897839390534;699.0039194148344;700.0898831519005;700.8423104801429;821.37575442664;612.9540284478682;615.0436071908181;615.689077016104;616.3897741236188;616.4698359410903;12889.291088990101;12930.159539629894;12942.482300707961;12947.093703440763;12967.481300747959;12106.81839772404;12402.689932751664;12427.93786031064;12491.687707807378;12657.873421265762;10236.129928956048;10368.066873981377;10381.273310868242;10467.319624224401;10671.253012289142;3534.8586056557706;3539.8938031859084;3548.077499850032;3574.267275208576;3583.964160358389;44812.55187448149;44842.77578612119;44912.77543612294;45016.549834501566;45142.54857451449;9955.352902061342;10030.648927287655;10089.697309080593;10112.063348371417;10132.898671013343;18232.179551920195;18250.269989200282;18280.26878924855;18283.72574411385;18296.817031829778;7284.854302913912;7482.8877566836545;7582.317591416799;7607.239276072459;7714.228577142353;4095.5904409559403;4161.83352665896;4261.31818908973;4280.507741609755;4307.396964424983;2970.0495841331;2994.431058098954;2999.760019198459;3007.368452624973;3021.4108248891694;545.4109561673383;551.481607289147;552.4861878453078;561.9859503512445;576.1904524143584;594.4887396838715;607.3683369295971;654.5254690349553;677.1704661789367;699.8915168148945;8552.61513231906;9195.218406435528;9226.26189904806;9241.290361283183;9665.806683866424;542.8507160530886;648.5265755998054;656.5535435903631;656.9343065693488;710.6198183971551;3821.407681809324;3929.587393323717;4143.08852052548;4492.483364413069;4505.7521836298665;49156.262656060186;49361.012779744204;49463;50073;50369;42721.57278427176;43632.56367436285;43753.56246437559;43820.78089609532;43850.561494385285;40911.38632920509;43215;43456;43850.561494385285;44683.77658111689;8532.530710810965;8542.40203185771;8694.17405346491;8846.115388461103;9088.545572721205;30021.84989075128;30418;31173.37653246877;31260;31311;39420.211595768495;39771.80114099411;40073.79963100166;40483.59516404798;40568.79715601403;10308.742281443025;10534.209934254808;10638.127705519311;10767.407792571485;11425.428728563373;12075.39623018828;12247.877521224673;12371.072169587496;12467.314297713712;12934.547290844775;10207;10644.520996555328;10861.076808471369;10861.78276434451;11005.834912476159;11395.829062564235;11785.823212651645;11867.109966752701;11917.16579839403;12198.329091899675;10880.510377032893;11378.43107844588;11383;11409.771804563696;11423.543058277575;9266.351355405057;9542.713718588453;9629.422234665943;9630.374025688308;9684.370515916444;9296.95351523238;9440.339176257596;9512.09635084666;9805.950970245103;9867.45728984884 05:01:37 INFO - PROCESS | 23218 | __end_tp_report 05:01:37 INFO - PROCESS | 23218 | __start_cc_report 05:01:37 INFO - PROCESS | 23218 | _x_x_mozilla_cycle_collect,1086 05:01:37 INFO - PROCESS | 23218 | __end_cc_report 05:01:37 INFO - PROCESS | 23218 | __startTimestamp1453294897235__endTimestamp 05:01:37 INFO - PROCESS | 23218 | 05:01:37 INFO - PROCESS | 23218 | ------- Summary: start ------- 05:01:37 INFO - PROCESS | 23218 | Number of tests: 6 05:01:37 INFO - PROCESS | 23218 | 05:01:37 INFO - PROCESS | 23218 | [#0] dojo.html Cycles:165 Average:5102.01 Median:5279.95 stddev:548.53 (10.4%) stddev-sans-first:527.85 05:01:37 INFO - PROCESS | 23218 | Values: 3125.8 3153.8 3202.8 3209.6 3234.2 4964.0 5039.6 5096.1 5096.7 5170.2 5049.4 5090.0 5098.1 5100.8 5160.6 4655.0 4681.2 4688.4 4736.8 4790.7 4721.5 4738.8 4765.2 4789.1 4802.1 4592.9 4619.7 4673.4 4674.4 4694.2 4611.0 4624.5 4630.5 4632.3 4667.0 4525.3 4605.7 4611.3 4621.8 4654.7 4907.8 4914.8 4929.7 4955.8 4981.9 5520.1 5534.3 5535.5 5541.8 5546.2 5441.7 5556.0 5568.5 5602.2 5622.9 5126.3 5151.4 5152.6 5156.5 5170.5 5610.0 5635.0 5638.8 5641.4 5651.4 5284.2 5359.7 5401.8 5419.0 5423.3 5495.5 5530.2 5533.7 5536.1 5582.6 5454.0 5470.3 5473.6 5480.8 5521.0 5377.2 5408.1 5455.0 5531.8 5564.9 4250.7 4283.9 4291.5 4320.7 4322.0 3799.1 3809.9 3829.5 3858.5 3859.9 5045.4 5065.4 5072.0 5099.1 5145.8 5517.2 5537.1 5543.8 5548.6 5561.0 5154.1 5165.9 5168.7 5171.1 5210.8 4637.5 4719.2 4739.5 4753.9 4815.9 5671.6 5694.1 5703.3 5703.9 5704.6 5488.8 5488.8 5492.3 5493.0 5545.5 5689.6 5742.8 5769.5 5780.9 5808.5 5383.0 5386.2 5390.0 5391.0 5397.2 5398.6 5445.7 5450.5 5451.8 5491.3 5266.0 5315.9 5339.2 5394.9 5410.8 5280.2 5293.9 5296.4 5298.5 5300.3 5213.1 5213.9 5218.9 5221.5 5270.1 5285.8 5318.2 5338.2 5410.2 5414.6 5267.5 5279.9 5280.0 5318.3 5329.8 05:01:37 INFO - PROCESS | 23218 | 05:01:37 INFO - PROCESS | 23218 | [#1] ext.html Cycles:180 Average:47412.01 Median:19350.10 stddev:85384.49 (441.3%) stddev-sans-first:85551.43 05:01:37 INFO - PROCESS | 23218 | Values: 521.3 522.1 546.0 558.6 582.1 29022.1 29404.7 29437.3 29438.1 29463.4 37124.8 37224.8 37443.3 37465.1 37501.8 8650.8 8894.4 8894.6 8896.8 8905.0 8623.6 8759.3 8763.6 8771.2 8778.1 8730.8 8859.8 8899.6 8901.0 8915.8 8731.0 8775.2 8803.2 8815.1 8823.0 8590.7 8666.9 8689.3 8728.1 8729.2 36709.8 36901.0 36993.3 39444.0 39445.0 3216.2 3218.5 3658.5 3774.0 4104.5 30281.7 30409.7 30536.2 30954.1 31492.4 3422.2 3436.5 3514.1 3533.7 3581.7 263600.0 264387.0 265032.0 265268.0 265624.0 53704.0 54005.5 59546.7 59980.4 60623.4 55359.7 55807.0 56110.4 56119.0 56146.9 14739.4 15026.1 15032.2 15053.1 15067.4 11048.2 11407.2 11424.3 11514.6 12118.2 19569.6 19637.4 19684.7 19691.6 19776.5 7400.1 7560.5 7571.8 7624.7 7732.5 967.5 1020.9 1029.6 1049.7 1097.4 29223.4 29374.9 29486.0 30168.2 30669.4 1031.1 1049.6 1066.8 1069.3 1072.3 13544.2 15720.0 15788.4 16499.9 16688.2 309432.0 311231.0 312423.0 312557.0 312907.0 51403.7 52871.2 53019.0 53123.0 53177.2 1220.6 1273.6 1330.3 1366.0 1367.9 25657.6 26397.9 26801.3 26817.3 26874.0 38574.6 38830.2 38987.2 38993.8 43659.0 184131.0 413636.0 421713.0 422281.0 423018.0 30636.5 31269.8 31339.8 31359.0 31434.7 43032.1 43250.1 44235.6 44406.1 44457.1 31970.0 32363.0 32472.7 32639.4 32654.8 35186.1 35241.1 35474.0 35566.3 35719.3 34964.5 35455.3 35734.6 35748.8 35781.0 31148.7 31998.7 32596.8 32609.7 32623.3 23990.5 24687.8 24712.3 25069.2 25168.2 05:01:37 INFO - PROCESS | 23218 | 05:01:37 INFO - PROCESS | 23218 | [#2] jquery.html Cycles:180 Average:27157.59 Median:492068.50 stddev:86516.95 (17.6%) stddev-sans-first:86736.22 05:01:37 INFO - PROCESS | 23218 | Values: 345.9 347.0 347.4 349.2 358.4 13694.9 14126.4 15625.5 16398.3 18188.8 15670.2 15826.2 17041.4 17206.6 17223.9 5084.1 5379.5 5387.8 5390.2 5390.5 3957.1 4071.6 5261.9 5513.0 5736.8 5087.2 5619.5 5668.4 5693.1 5695.2 5213.2 5214.3 5222.1 5246.3 5248.0 5026.9 5251.4 5259.6 5263.1 5274.6 11870.5 19367.2 19811.8 19883.6 20093.2 1975.0 2097.8 2137.0 2148.4 2160.4 8770.6 9340.4 9369.8 10943.0 11225.5 1720.8 1809.4 1816.0 1816.4 1829.1 54351.7 56474.7 56764.7 58024.0 58305.4 9793.1 9881.6 9913.9 9936.6 9980.1 12973.1 13120.7 13134.8 13143.5 13153.2 7207.5 7293.0 7299.1 7415.6 7450.3 6983.9 7046.3 7057.3 7077.4 7126.6 4021.5 4310.7 4379.6 4406.9 4434.0 1707.5 1758.9 1833.7 1834.2 1851.9 908.6 934.3 939.7 1044.4 1061.3 14285.0 15134.3 15900.8 16066.4 16956.3 927.9 934.7 960.6 968.4 1006.4 9390.9 9581.4 9914.4 9991.9 10203.9 487440.0 496697.0 539240.0 547338.0 571820.0 56878.4 73664.3 73901.6 73981.6 75709.0 1174.9 1175.3 1209.9 1226.0 1248.6 15124.5 15241.3 15381.9 15458.3 15684.8 33193.2 33251.5 33423.8 33645.7 33990.0 42838.0 44506.0 45081.0 47946.8 48000.5 6880.8 7076.0 7078.1 7275.1 7439.1 10841.0 10962.9 11295.8 11419.7 11546.9 9238.7 9239.7 9554.8 9629.4 9712.7 9487.9 9530.4 9583.8 10095.5 10123.8 9845.5 9962.5 10015.4 10060.8 10084.6 7220.7 7411.3 7429.5 7442.6 7470.6 6706.3 9117.2 9156.0 10151.1 10157.4 05:01:37 INFO - PROCESS | 23218 | 05:01:37 INFO - PROCESS | 23218 | [#3] mootools.html Cycles:180 Average:5503.99 Median:6504.72 stddev:2793.58 (42.9%) stddev-sans-first:2783.75 05:01:37 INFO - PROCESS | 23218 | Values: 1325.0 1473.4 1474.2 1632.6 1791.2 6915.9 7481.0 7663.4 7691.2 7694.3 7606.2 7784.3 7790.7 7793.2 7793.4 2001.2 2047.4 2050.9 2280.0 2312.1 2065.7 2267.1 2304.3 2328.2 2332.4 2214.9 2256.2 2264.5 2290.9 2293.2 2211.3 2235.6 2242.4 2245.9 2266.2 2281.1 2295.8 2297.2 2299.5 2313.6 7528.5 7621.7 7626.0 7626.3 7629.6 4749.6 4842.9 4856.9 4874.0 4887.2 3150.3 3209.3 3244.3 3246.3 3247.7 1122.0 1128.3 1130.5 1133.0 1224.5 10600.0 10616.9 10637.4 10661.1 10671.0 4311.2 4385.5 4427.8 4430.2 4474.5 9253.0 9262.3 9263.4 9265.2 9267.2 4859.1 4871.2 4897.6 4900.5 4903.8 4406.8 4410.8 4461.6 4466.3 4466.4 3538.8 3619.2 3756.1 3840.2 3869.2 1214.8 1216.4 1250.0 1251.5 1252.2 1319.7 1342.6 1348.9 1354.4 1362.1 7120.5 7422.3 7602.5 7609.7 7612.5 1093.9 1113.5 1129.6 1130.5 1142.5 5912.2 5954.9 6004.2 6005.1 6012.0 8868.1 8894.6 8976.7 8979.5 9117.0 8926.6 9017.2 9034.5 9035.4 9036.6 7055.7 7080.2 7209.2 7238.2 7241.7 7225.2 7273.7 7351.3 7358.7 7359.7 8364.7 8386.6 8595.6 8724.3 8745.6 8668.2 8771.6 8771.8 8916.3 8921.6 7120.1 7193.7 7219.8 7222.3 7229.6 6599.5 6785.6 7167.1 7473.5 7552.7 7002.2 7038.4 7081.2 7119.3 7388.9 7023.3 7091.2 7113.5 7187.2 7215.6 7187.1 7196.1 7223.1 7231.2 7263.1 6430.0 6579.4 6585.3 6587.2 6648.0 6608.0 6652.5 6658.4 6664.1 6675.2 05:01:37 INFO - PROCESS | 23218 | 05:01:37 INFO - PROCESS | 23218 | [#4] prototype.html Cycles:180 Average:5132.11 Median:5819.99 stddev:1535.07 (26.4%) stddev-sans-first:1496.46 05:01:37 INFO - PROCESS | 23218 | Values: 329.6 331.4 337.7 347.5 352.5 5628.7 5756.1 5772.7 5790.3 5798.0 5536.7 5675.9 5684.3 5687.3 5739.8 4480.9 4483.1 4485.0 4488.6 4495.9 4316.5 4378.3 4390.7 4474.3 4490.3 4411.4 4427.8 4436.6 4438.1 4441.0 4425.3 4435.6 4442.9 4444.6 4453.3 3910.5 3910.5 3918.1 3920.7 3922.2 5363.5 5489.6 5491.8 5499.6 5509.4 5106.7 5110.3 5114.2 5115.7 5118.2 6046.7 6049.9 6056.7 6060.7 6061.7 4152.0 4290.4 4291.2 4293.9 4303.8 6030.7 6330.9 6408.0 6417.3 6428.0 4378.8 4393.2 4401.5 4402.7 4407.4 4454.9 4457.1 4463.2 4464.3 4470.2 5017.9 5108.2 5110.8 5115.8 5119.7 6156.7 6157.5 6160.0 6163.2 6164.4 1568.7 1572.7 1578.3 1578.4 1579.3 1067.8 1081.2 1081.7 1086.6 1086.7 5827.9 5832.2 5840.2 5852.3 5857.4 6307.9 6311.3 6321.1 6322.7 6324.7 5812.1 5832.4 5836.4 5840.7 5849.9 3255.5 3389.5 3393.6 3394.3 3394.4 6556.8 6564.4 6571.0 6577.2 6596.4 6406.2 6454.8 6456.3 6456.9 6471.6 6471.3 6559.6 6615.8 6624.7 6639.6 6269.2 6330.9 6332.1 6336.3 6338.7 6071.8 6186.5 6251.6 6275.6 6283.0 6453.7 6591.2 6616.9 6630.8 6633.5 4315.9 4339.5 4342.5 4347.4 4348.7 6189.9 6316.1 6318.0 6336.7 6338.5 6167.0 6172.7 6182.7 6183.8 6187.8 6161.4 6161.4 6162.6 6164.1 6175.0 5945.5 6067.7 6070.7 6070.8 6081.1 6169.8 6195.4 6198.3 6199.2 6209.5 5992.0 6012.4 6016.5 6017.9 6020.2 05:01:37 INFO - PROCESS | 23218 | 05:01:37 INFO - PROCESS | 23218 | [#5] yui.html Cycles:180 Average:12917.34 Median:43544.28 stddev:14097.61 (32.4%) stddev-sans-first:14107.64 05:01:37 INFO - PROCESS | 23218 | Values: 770.8 842.4 849.1 862.0 863.9 13020.7 13276.5 13351.3 13356.2 13397.8 11923.3 12384.7 12468.6 12520.2 12546.1 665.7 798.5 811.0 814.7 815.1 791.7 793.9 794.3 796.5 799.8 692.8 844.4 845.3 848.3 849.3 697.4 699.0 700.1 700.8 821.4 613.0 615.0 615.7 616.4 616.5 12889.3 12930.2 12942.5 12947.1 12967.5 12106.8 12402.7 12427.9 12491.7 12657.9 10236.1 10368.1 10381.3 10467.3 10671.3 3534.9 3539.9 3548.1 3574.3 3584.0 44812.6 44842.8 44912.8 45016.5 45142.5 9955.4 10030.6 10089.7 10112.1 10132.9 18232.2 18250.3 18280.3 18283.7 18296.8 7284.9 7482.9 7582.3 7607.2 7714.2 4095.6 4161.8 4261.3 4280.5 4307.4 2970.0 2994.4 2999.8 3007.4 3021.4 545.4 551.5 552.5 562.0 576.2 594.5 607.4 654.5 677.2 699.9 8552.6 9195.2 9226.3 9241.3 9665.8 542.9 648.5 656.6 656.9 710.6 3821.4 3929.6 4143.1 4492.5 4505.8 49156.3 49361.0 49463.0 50073.0 50369.0 42721.6 43632.6 43753.6 43820.8 43850.6 40911.4 43215.0 43456.0 43850.6 44683.8 8532.5 8542.4 8694.2 8846.1 9088.5 30021.8 30418.0 31173.4 31260.0 31311.0 39420.2 39771.8 40073.8 40483.6 40568.8 10308.7 10534.2 10638.1 10767.4 11425.4 12075.4 12247.9 12371.1 12467.3 12934.5 10207.0 10644.5 10861.1 10861.8 11005.8 11395.8 11785.8 11867.1 11917.2 12198.3 10880.5 11378.4 11383.0 11409.8 11423.5 9266.4 9542.7 9629.4 9630.4 9684.4 9297.0 9440.3 9512.1 9806.0 9867.5 05:01:37 INFO - PROCESS | 23218 | -------- Summary: end -------- 05:01:37 INFO - PROCESS | 23218 | 05:01:37 INFO - TEST-INFO | 23218: exit 0 05:01:37 INFO - TEST-OK | dromaeo_css | took 1112742ms 05:01:37 INFO - TEST-START | kraken 05:01:37 INFO - operating with platform_type : linux_ 05:01:37 INFO - Initialising browser for kraken test... 05:01:37 INFO - TEST-INFO | started process 23417 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp1PLyPI/profile http://localhost:60821/getInfo.html) 05:01:41 INFO - PROCESS | 23417 | __metrics Screen width/height:1600/1200 05:01:41 INFO - PROCESS | 23417 | colorDepth:24 05:01:41 INFO - PROCESS | 23417 | Browser inner width/height: 1024/697 05:01:41 INFO - PROCESS | 23417 | __metrics 05:01:41 INFO - PROCESS | 23417 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:01:41 INFO - PROCESS | 23417 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:01:42 INFO - TEST-INFO | 23417: exit 0 05:01:42 INFO - Browser initialized. 05:01:42 INFO - Running cycle 1/1 for kraken test... 05:01:42 INFO - TEST-INFO | started process 23496 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp1PLyPI/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:01:54 INFO - PROCESS | 23496 | RSS: Main: 149757952 05:01:54 INFO - PROCESS | 23496 | 05:01:57 INFO - PROCESS | 23496 | Cycle 1(1): loaded http://localhost:60821/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60821/tests/kraken/driver.html?testName=audio-beat-detection) 05:01:57 INFO - PROCESS | 23496 | RSS: Main: 188157952 05:01:57 INFO - PROCESS | 23496 | 05:02:00 INFO - PROCESS | 23496 | Cycle 1(1): loaded http://localhost:60821/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60821/tests/kraken/driver.html?testName=audio-dft) 05:02:00 INFO - PROCESS | 23496 | RSS: Main: 177537024 05:02:00 INFO - PROCESS | 23496 | 05:02:03 INFO - PROCESS | 23496 | Cycle 1(1): loaded http://localhost:60821/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60821/tests/kraken/driver.html?testName=audio-fft) 05:02:04 INFO - PROCESS | 23496 | RSS: Main: 161443840 05:02:04 INFO - PROCESS | 23496 | 05:02:06 INFO - PROCESS | 23496 | Cycle 1(1): loaded http://localhost:60821/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60821/tests/kraken/driver.html?testName=audio-oscillator) 05:02:06 INFO - PROCESS | 23496 | RSS: Main: 163184640 05:02:06 INFO - PROCESS | 23496 | 05:02:09 INFO - PROCESS | 23496 | Cycle 1(1): loaded http://localhost:60821/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60821/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:02:09 INFO - PROCESS | 23496 | RSS: Main: 167059456 05:02:09 INFO - PROCESS | 23496 | 05:02:12 INFO - PROCESS | 23496 | Cycle 1(1): loaded http://localhost:60821/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60821/tests/kraken/driver.html?testName=imaging-darkroom) 05:02:13 INFO - PROCESS | 23496 | RSS: Main: 166465536 05:02:13 INFO - PROCESS | 23496 | 05:02:16 INFO - PROCESS | 23496 | Cycle 1(1): loaded http://localhost:60821/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60821/tests/kraken/driver.html?testName=imaging-desaturate) 05:02:17 INFO - PROCESS | 23496 | RSS: Main: 165298176 05:02:17 INFO - PROCESS | 23496 | 05:02:19 INFO - PROCESS | 23496 | Cycle 1(1): loaded http://localhost:60821/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60821/tests/kraken/driver.html?testName=json-parse-financial) 05:02:20 INFO - PROCESS | 23496 | RSS: Main: 166490112 05:02:20 INFO - PROCESS | 23496 | 05:02:21 INFO - PROCESS | 23496 | Cycle 1(1): loaded http://localhost:60821/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60821/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:02:22 INFO - PROCESS | 23496 | RSS: Main: 178237440 05:02:22 INFO - PROCESS | 23496 | 05:02:24 INFO - PROCESS | 23496 | Cycle 1(1): loaded http://localhost:60821/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60821/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:02:24 INFO - PROCESS | 23496 | RSS: Main: 176123904 05:02:24 INFO - PROCESS | 23496 | 05:02:26 INFO - PROCESS | 23496 | Cycle 1(1): loaded http://localhost:60821/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60821/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:02:27 INFO - PROCESS | 23496 | RSS: Main: 188137472 05:02:27 INFO - PROCESS | 23496 | 05:02:29 INFO - PROCESS | 23496 | Cycle 1(1): loaded http://localhost:60821/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60821/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:02:30 INFO - PROCESS | 23496 | RSS: Main: 194490368 05:02:30 INFO - PROCESS | 23496 | 05:02:33 INFO - PROCESS | 23496 | Cycle 1(1): loaded http://localhost:60821/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60821/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:02:33 INFO - PROCESS | 23496 | RSS: Main: 192884736 05:02:33 INFO - PROCESS | 23496 | 05:02:35 INFO - PROCESS | 23496 | Cycle 1(1): loaded http://localhost:60821/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60821/tests/kraken/driver.html?testName=ai-astar) 05:02:35 INFO - PROCESS | 23496 | RSS: Main: 249446400 05:02:35 INFO - PROCESS | 23496 | 05:02:35 INFO - PROCESS | 23496 | __start_tp_report 05:02:35 INFO - PROCESS | 23496 | _x_x_mozilla_page_load 05:02:35 INFO - PROCESS | 23496 | _x_x_mozilla_page_load_details 05:02:35 INFO - PROCESS | 23496 | |i|pagename|runs| 05:02:35 INFO - PROCESS | 23496 | |0;ai-astar;110;109;104;108;109;110;110;110;103;110 05:02:35 INFO - PROCESS | 23496 | |1;audio-beat-detection;148;124;147;164;126;152;150;138;172;132 05:02:35 INFO - PROCESS | 23496 | |2;audio-dft;162;161;161;161;163;161;161;160;162;160 05:02:35 INFO - PROCESS | 23496 | |3;audio-fft;74;73;129;95;73;73;72;115;90;73 05:02:35 INFO - PROCESS | 23496 | |4;audio-oscillator;97;96;141;96;95;96;148;96;95;137 05:02:35 INFO - PROCESS | 23496 | |5;imaging-gaussian-blur;110;109;110;110;109;110;109;110;109;109 05:02:35 INFO - PROCESS | 23496 | |6;imaging-darkroom;145;145;145;146;145;146;145;146;145;146 05:02:35 INFO - PROCESS | 23496 | |7;imaging-desaturate;96;96;96;96;96;96;97;97;95;96 05:02:35 INFO - PROCESS | 23496 | |8;json-parse-financial;57;55;55;55;55;54;55;55;54;53 05:02:35 INFO - PROCESS | 23496 | |9;json-stringify-tinderbox;69;68;68;69;69;73;69;69;69;69 05:02:35 INFO - PROCESS | 23496 | |10;stanford-crypto-aes;88;81;83;83;84;83;83;85;90;82 05:02:35 INFO - PROCESS | 23496 | |11;stanford-crypto-ccm;120;114;117;118;113;116;122;120;122;117 05:02:35 INFO - PROCESS | 23496 | |12;stanford-crypto-pbkdf2;150;151;154;138;147;136;153;154;150;148 05:02:35 INFO - PROCESS | 23496 | |13;stanford-crypto-sha256-iterative;67;67;67;66;67;66;66;70;66;67 05:02:35 INFO - PROCESS | 23496 | __end_tp_report 05:02:35 INFO - PROCESS | 23496 | __start_cc_report 05:02:35 INFO - PROCESS | 23496 | _x_x_mozilla_cycle_collect,944 05:02:35 INFO - PROCESS | 23496 | __end_cc_report 05:02:35 INFO - PROCESS | 23496 | __startTimestamp1453294955611__endTimestamp 05:02:35 INFO - PROCESS | 23496 | 05:02:35 INFO - PROCESS | 23496 | ------- Summary: start ------- 05:02:35 INFO - PROCESS | 23496 | Number of tests: 14 05:02:35 INFO - PROCESS | 23496 | 05:02:35 INFO - PROCESS | 23496 | [#0] ai-astar Cycles:10 Average:108.30 Median:110.00 stddev:2.63 (2.4%) stddev-sans-first:2.71 05:02:35 INFO - PROCESS | 23496 | Values: 110.0 109.0 104.0 108.0 109.0 110.0 110.0 110.0 103.0 110.0 05:02:35 INFO - PROCESS | 23496 | 05:02:35 INFO - PROCESS | 23496 | [#1] audio-beat-detection Cycles:10 Average:145.30 Median:149.00 stddev:15.62 (10.5%) stddev-sans-first:16.54 05:02:35 INFO - PROCESS | 23496 | Values: 148.0 124.0 147.0 164.0 126.0 152.0 150.0 138.0 172.0 132.0 05:02:35 INFO - PROCESS | 23496 | 05:02:35 INFO - PROCESS | 23496 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:0.92 (0.6%) stddev-sans-first:0.93 05:02:35 INFO - PROCESS | 23496 | Values: 162.0 161.0 161.0 161.0 163.0 161.0 161.0 160.0 162.0 160.0 05:02:35 INFO - PROCESS | 23496 | 05:02:35 INFO - PROCESS | 23496 | [#3] audio-fft Cycles:10 Average:86.70 Median:73.00 stddev:20.54 (28.1%) stddev-sans-first:21.27 05:02:35 INFO - PROCESS | 23496 | Values: 74.0 73.0 129.0 95.0 73.0 73.0 72.0 115.0 90.0 73.0 05:02:35 INFO - PROCESS | 23496 | 05:02:35 INFO - PROCESS | 23496 | [#4] audio-oscillator Cycles:10 Average:109.70 Median:96.00 stddev:22.45 (23.4%) stddev-sans-first:23.34 05:02:35 INFO - PROCESS | 23496 | Values: 97.0 96.0 141.0 96.0 95.0 96.0 148.0 96.0 95.0 137.0 05:02:35 INFO - PROCESS | 23496 | 05:02:35 INFO - PROCESS | 23496 | [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:110.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 05:02:35 INFO - PROCESS | 23496 | Values: 110.0 109.0 110.0 110.0 109.0 110.0 109.0 110.0 109.0 109.0 05:02:35 INFO - PROCESS | 23496 | 05:02:35 INFO - PROCESS | 23496 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 05:02:35 INFO - PROCESS | 23496 | Values: 145.0 145.0 145.0 146.0 145.0 146.0 145.0 146.0 145.0 146.0 05:02:35 INFO - PROCESS | 23496 | 05:02:35 INFO - PROCESS | 23496 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 05:02:35 INFO - PROCESS | 23496 | Values: 96.0 96.0 96.0 96.0 96.0 96.0 97.0 97.0 95.0 96.0 05:02:35 INFO - PROCESS | 23496 | 05:02:35 INFO - PROCESS | 23496 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:55.00 stddev:1.03 (1.9%) stddev-sans-first:0.73 05:02:35 INFO - PROCESS | 23496 | Values: 57.0 55.0 55.0 55.0 55.0 54.0 55.0 55.0 54.0 53.0 05:02:35 INFO - PROCESS | 23496 | 05:02:35 INFO - PROCESS | 23496 | [#9] json-stringify-tinderbox Cycles:10 Average:69.20 Median:69.00 stddev:1.40 (2.0%) stddev-sans-first:1.48 05:02:35 INFO - PROCESS | 23496 | Values: 69.0 68.0 68.0 69.0 69.0 73.0 69.0 69.0 69.0 69.0 05:02:35 INFO - PROCESS | 23496 | 05:02:35 INFO - PROCESS | 23496 | [#10] stanford-crypto-aes Cycles:10 Average:84.20 Median:83.50 stddev:2.78 (3.3%) stddev-sans-first:2.59 05:02:35 INFO - PROCESS | 23496 | Values: 88.0 81.0 83.0 83.0 84.0 83.0 83.0 85.0 90.0 82.0 05:02:35 INFO - PROCESS | 23496 | 05:02:35 INFO - PROCESS | 23496 | [#11] stanford-crypto-ccm Cycles:10 Average:117.90 Median:119.00 stddev:3.11 (2.6%) stddev-sans-first:3.20 05:02:35 INFO - PROCESS | 23496 | Values: 120.0 114.0 117.0 118.0 113.0 116.0 122.0 120.0 122.0 117.0 05:02:35 INFO - PROCESS | 23496 | 05:02:35 INFO - PROCESS | 23496 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.10 Median:150.50 stddev:6.31 (4.2%) stddev-sans-first:6.66 05:02:35 INFO - PROCESS | 23496 | Values: 150.0 151.0 154.0 138.0 147.0 136.0 153.0 154.0 150.0 148.0 05:02:35 INFO - PROCESS | 23496 | 05:02:35 INFO - PROCESS | 23496 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:1.20 (1.8%) stddev-sans-first:1.27 05:02:35 INFO - PROCESS | 23496 | Values: 67.0 67.0 67.0 66.0 67.0 66.0 66.0 70.0 66.0 67.0 05:02:35 INFO - PROCESS | 23496 | -------- Summary: end -------- 05:02:35 INFO - PROCESS | 23496 | 05:02:36 INFO - TEST-INFO | 23496: exit 0 05:02:36 INFO - TEST-OK | kraken | took 58615ms 05:02:36 INFO - TEST-START | v8_7 05:02:36 INFO - operating with platform_type : linux_ 05:02:36 INFO - Initialising browser for v8_7 test... 05:02:36 INFO - TEST-INFO | started process 23744 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpDTN7s0/profile http://localhost:60821/getInfo.html) 05:02:40 INFO - PROCESS | 23744 | __metrics Screen width/height:1600/1200 05:02:40 INFO - PROCESS | 23744 | colorDepth:24 05:02:40 INFO - PROCESS | 23744 | Browser inner width/height: 1024/697 05:02:40 INFO - PROCESS | 23744 | __metrics 05:02:40 INFO - PROCESS | 23744 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:02:40 INFO - PROCESS | 23744 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:02:41 INFO - TEST-INFO | 23744: exit 0 05:02:41 INFO - Browser initialized. 05:02:41 INFO - Running cycle 1/1 for v8_7 test... 05:02:41 INFO - TEST-INFO | started process 23826 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpDTN7s0/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:02:53 INFO - PROCESS | 23826 | RSS: Main: 148779008 05:02:53 INFO - PROCESS | 23826 | 05:03:15 INFO - PROCESS | 23826 | Cycle 1(1): loaded http://localhost:60821/tests/v8_7/run.html (next: http://localhost:60821/tests/v8_7/run.html) 05:03:16 INFO - PROCESS | 23826 | RSS: Main: 529543168 05:03:16 INFO - PROCESS | 23826 | 05:03:16 INFO - PROCESS | 23826 | __start_tp_report 05:03:16 INFO - PROCESS | 23826 | _x_x_mozilla_page_load 05:03:16 INFO - PROCESS | 23826 | _x_x_mozilla_page_load_details 05:03:16 INFO - PROCESS | 23826 | |i|pagename|runs| 05:03:16 INFO - PROCESS | 23826 | |0;Richards;167.98252981689905 05:03:16 INFO - PROCESS | 23826 | |1;DeltaBlue;188.25301204819277 05:03:16 INFO - PROCESS | 23826 | |2;Encrypt;279.87685418415896 05:03:16 INFO - PROCESS | 23826 | |3;Decrypt;5273.684210526316 05:03:16 INFO - PROCESS | 23826 | |4;RayTrace;1127.3957158962796 05:03:16 INFO - PROCESS | 23826 | |5;Earley;787.5688434303698 05:03:16 INFO - PROCESS | 23826 | |6;Boyer;12395.061728395061 05:03:16 INFO - PROCESS | 23826 | |7;RegExp;43416.666666666664 05:03:16 INFO - PROCESS | 23826 | |8;Splay;558.9714924538848 05:03:16 INFO - PROCESS | 23826 | |9;NavierStokes;4826.923076923077 05:03:16 INFO - PROCESS | 23826 | __end_tp_report 05:03:16 INFO - PROCESS | 23826 | __startTimestamp1453294996000__endTimestamp 05:03:16 INFO - PROCESS | 23826 | 05:03:16 INFO - PROCESS | 23826 | ------- Summary: start ------- 05:03:16 INFO - PROCESS | 23826 | Number of tests: 10 05:03:16 INFO - PROCESS | 23826 | 05:03:16 INFO - PROCESS | 23826 | [#0] Richards Cycles:1 Average:167.98 Median:167.98 stddev:0.00 (0.0%) 05:03:16 INFO - PROCESS | 23826 | Values: 168.0 05:03:16 INFO - PROCESS | 23826 | 05:03:16 INFO - PROCESS | 23826 | [#1] DeltaBlue Cycles:1 Average:188.25 Median:188.25 stddev:0.00 (0.0%) 05:03:16 INFO - PROCESS | 23826 | Values: 188.3 05:03:16 INFO - PROCESS | 23826 | 05:03:16 INFO - PROCESS | 23826 | [#2] Encrypt Cycles:1 Average:279.88 Median:279.88 stddev:0.00 (0.0%) 05:03:16 INFO - PROCESS | 23826 | Values: 279.9 05:03:16 INFO - PROCESS | 23826 | 05:03:16 INFO - PROCESS | 23826 | [#3] Decrypt Cycles:1 Average:5273.68 Median:5273.68 stddev:0.00 (0.0%) 05:03:16 INFO - PROCESS | 23826 | Values: 5273.7 05:03:16 INFO - PROCESS | 23826 | 05:03:16 INFO - PROCESS | 23826 | [#4] RayTrace Cycles:1 Average:1127.40 Median:1127.40 stddev:0.00 (0.0%) 05:03:16 INFO - PROCESS | 23826 | Values: 1127.4 05:03:16 INFO - PROCESS | 23826 | 05:03:16 INFO - PROCESS | 23826 | [#5] Earley Cycles:1 Average:787.57 Median:787.57 stddev:0.00 (0.0%) 05:03:16 INFO - PROCESS | 23826 | Values: 787.6 05:03:16 INFO - PROCESS | 23826 | 05:03:16 INFO - PROCESS | 23826 | [#6] Boyer Cycles:1 Average:12395.06 Median:12395.06 stddev:0.00 (0.0%) 05:03:16 INFO - PROCESS | 23826 | Values: 12395.1 05:03:16 INFO - PROCESS | 23826 | 05:03:16 INFO - PROCESS | 23826 | [#7] RegExp Cycles:1 Average:43416.67 Median:43416.67 stddev:0.00 (0.0%) 05:03:16 INFO - PROCESS | 23826 | Values: 43416.7 05:03:16 INFO - PROCESS | 23826 | 05:03:16 INFO - PROCESS | 23826 | [#8] Splay Cycles:1 Average:558.97 Median:558.97 stddev:0.00 (0.0%) 05:03:16 INFO - PROCESS | 23826 | Values: 559.0 05:03:16 INFO - PROCESS | 23826 | 05:03:16 INFO - PROCESS | 23826 | [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 05:03:16 INFO - PROCESS | 23826 | Values: 4826.9 05:03:16 INFO - PROCESS | 23826 | -------- Summary: end -------- 05:03:16 INFO - PROCESS | 23826 | 05:03:16 INFO - TEST-INFO | 23826: exit 0 05:03:16 INFO - TEST-OK | v8_7 | took 40370ms 05:03:16 INFO - SUITE-END | took 1211s 05:03:17 INFO - Completed test suite (00:20:11) 05:03:17 INFO - Working with test: dromaeo_css 05:03:17 INFO - Generating results file: dromaeo_css 05:03:17 INFO - Working with test: kraken 05:03:17 INFO - Generating results file: kraken 05:03:17 INFO - javascript benchmark 05:03:17 INFO - Working with test: v8_7 05:03:17 INFO - Generating results file: v8_7 05:03:17 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:03:17 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,63,35]] 05:03:17 INFO - process_Request line: dromaeo_css 6775.98 graph.html#tests=[[72,63,35]] 05:03:17 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:03:17 INFO - process_Request line: kraken 1503.30 graph.html#tests=[[232,63,35]] 05:03:17 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:03:17 INFO - process_Request line: v8_7 20055.51 graph.html#tests=[[230,63,35]] 05:03:17 INFO - RETURN: dromaeo_css: 6775.98 05:03:17 INFO - RETURN: kraken: 1503.30 05:03:17 INFO - RETURN: v8_7: 20055.51 05:03:17 INFO - javascript benchmark 05:03:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3125.7655675824317, 3153.826539540326, 3202.7758056936023, 3209.5827542419497, 3234.175285302248, 4964.0, 5039.5716364109, 5096.082705113083, 5096.745162741862, 5170.172772356424, 5049.4193167785625, 5089.974550127254, 5098.107831129547, 5100.795968161278, 5160.612954028444, 4654.999175177336, 4681.180793361165, 4688.390509233795, 4736.763161841911, 4790.66465347424, 4721.527847215269, 4738.763061846894, 4765.189917713979, 4789.066132104241, 4802.135615589193, 4592.862214133581, 4619.722816631013, 4673.415823022122, 4674.392328997243, 4694.155052090622, 4610.953890461086, 4624.491305956342, 4630.513796051433, 4632.3051542268595, 4667.0, 4525.32120181972, 4605.746683932382, 4611.262198048296, 4621.792019359137, 4654.720716757005, 4907.803687852517, 4914.827981020647, 4929.704217746947, 4955.82654607087, 4981.900361992776, 5520.1167813149705, 5534.252875861747, 5535.529479994206, 5541.750621222014, 5546.223528705985, 5441.700706461143, 5555.972220138873, 5568.52667523261, 5602.215689803431, 5622.887542249173, 5126.333576635014, 5151.381834179922, 5152.58779297659, 5156.535911767922, 5170.482951704837, 5610.0, 5634.97182514093, 5638.830835074954, 5641.351244606841, 5651.406602306781, 5284.180951952453, 5359.705216213068, 5401.783928642811, 5419.0245755764345, 5423.267858839085, 5495.450454954473, 5530.198121272473, 5533.667979921218, 5536.058869992031, 5582.581306402036, 5454.0, 5470.343558772973, 5473.644213126214, 5480.808171713971, 5521.033819081645, 5377.166539186354, 5408.0535906216255, 5454.972725136428, 5531.751071201806, 5564.860878478071, 4250.702450828412, 4283.935740963888, 4291.485021797404, 4320.740755554677, 4321.956780432155, 3799.069228039148, 3809.9047523811573, 3829.5021647185686, 3858.5369755629504, 3859.864904728321, 5045.369328833895, 5065.366829146356, 5072.0, 5099.107656160157, 5145.76844042019, 5517.227588137664, 5537.058700021006, 5543.833684989457, 5548.55611551075, 5561.026820306431, 5154.098032844312, 5165.9225111623355, 5168.715720635401, 5171.120909445403, 5210.7915683373, 4637.536246375403, 4719.244920812654, 4739.454962679267, 4753.904921901542, 4815.855524334275, 5671.631343962629, 5694.1458781183155, 5703.344115426696, 5703.914441283384, 5704.572157088235, 5488.807891723771, 5488.835334939959, 5492.313460817398, 5492.972535137299, 5545.473180047889, 5689.630174038674, 5742.827715168552, 5769.451902069297, 5780.913286300793, 5808.477237048686, 5383.0, 5386.165144402624, 5390.00284947286, 5391.0, 5397.244385786072, 5398.568114550905, 5445.727713614224, 5450.5367043801725, 5451.809186678447, 5491.313585801775, 5265.973670131625, 5315.946840531546, 5339.199120132012, 5394.919076213781, 5410.756515956713, 5280.155175171954, 5293.920591191212, 5296.390915044665, 5298.470152984671, 5300.284461597635, 5213.061648903234, 5213.947860521346, 5218.947810521846, 5221.451747566451, 5270.077736396039, 5285.841424757264, 5318.202269659582, 5338.225957236256, 5410.242566040679, 5414.593905457185, 5267.525922666979, 5279.9472005280995, 5279.973600132128, 5318.335208098988, 5329.840104796862], "unit": "score", "name": "dojo.html", "value": 5068.16542510869}, {"lowerIsBetter": false, "replicates": [521.2936471081684, 522.0889547739196, 545.9590530710193, 558.5782734035803, 582.1471544187765, 29022.129336119924, 29404.705952940465, 29437.2640683983, 29438.11685649431, 29463.410731785352, 37124.81437592808, 37224.81387593058, 37443.251134977356, 37465.06337341561, 37501.81249093758, 8650.826983460327, 8894.37739358242, 8894.644214231455, 8896.777580560472, 8905.020447750774, 8623.611937462798, 8759.255463285628, 8763.605637746285, 8771.16673915977, 8778.122187781202, 8730.781730456725, 8859.77850553738, 8899.644014239422, 8900.955495222515, 8915.821683566324, 8731.0, 8775.16635919593, 8803.20771130595, 8815.118488151198, 8823.0, 8590.699325523577, 8666.86999695005, 8689.348298877547, 8728.083551227093, 8729.170728780819, 36709.81645091758, 36901.0, 36993.26013479715, 39444.0, 39445.0, 3216.163797412666, 3218.5024252723993, 3658.487811706363, 3773.9998900291444, 4104.507459104897, 30281.697183028107, 30409.69590304091, 30536.236594085105, 30954.0713778587, 31492.37015259705, 3422.212891035051, 3436.484527320897, 3514.0863375522295, 3533.717302615785, 3581.7313701472494, 263600.0, 264387.0, 265032.0, 265268.0, 265624.0, 53704.0, 54005.45994540083, 59546.70226648839, 59980.400195997485, 60623.393766062654, 55359.723201383735, 55807.0, 56110.43889561134, 56119.0, 56146.9119198448, 14739.410423582936, 15026.098434093989, 15032.248387580577, 15053.096814191184, 15067.397304107932, 11048.226624136234, 11407.201495895373, 11424.257423267461, 11514.596989105508, 12118.212316199419, 19569.608607827762, 19637.410877673694, 19684.70472942907, 19691.60616787656, 19776.505587360432, 7400.111986561647, 7560.508566943131, 7571.848563028709, 7624.656890439833, 7732.458727889106, 967.5162418790604, 1020.8723909511311, 1029.629333439961, 1049.742813010802, 1097.4128841070149, 29223.415531689247, 29374.853125734233, 29486.0, 30168.24579385533, 30669.386612268077, 1031.0720351683394, 1049.5801679328176, 1066.823974044274, 1069.3102948598112, 1072.2922870905165, 13544.187348759106, 15720.0, 15788.368465261261, 16499.85317758536, 16688.165591720608, 309432.0, 311231.0, 312423.0, 312557.0, 312907.0, 51403.7429812856, 52871.20693189605, 53019.0, 53123.0, 53177.202341964905, 1220.6155061155885, 1273.5860845225154, 1330.3348325837276, 1365.9726805464034, 1367.883729882971, 25657.61513577335, 26397.875229651207, 26801.329966750985, 26817.329566760985, 26874.0, 38574.61425385823, 38830.2233955325, 38987.22025559416, 38993.80503097466, 43659.0, 184131.0, 413636.0, 421713.0, 422281.0, 423018.0, 30636.540451893685, 31269.8436507816, 31339.843300783352, 31359.0, 31434.68565314409, 43032.13935721206, 43250.134997300505, 44235.55764442314, 44406.11187776162, 44457.10971793165, 31970.0, 32363.0, 32472.675273246965, 32639.419973183503, 32654.836725816218, 35186.12034699051, 35241.118972025906, 35474.0, 35566.288674225856, 35719.28561428705, 34964.47553286652, 35455.29089418145, 35734.64265357313, 35748.821255893556, 35781.0, 31148.68851311458, 31998.68001319957, 32596.83701581477, 32609.673903260664, 32623.34753304968, 23990.45374660483, 24687.753122468544, 24712.258632240344, 25069.247922562354, 25168.24495265145], "unit": "score", "name": "ext.html", "value": 18112.807246374432}, {"lowerIsBetter": false, "replicates": [345.9117924929144, 346.95836499620043, 347.37125802297845, 349.15504479160427, 358.4372535119863, 13694.93152534236, 14126.43494260231, 15625.531234062983, 16398.26207820648, 18188.818111818877, 15670.216489175524, 15826.208689565534, 17041.403550875722, 17206.56983575411, 17223.91388043058, 5084.13569693153, 5379.462053794608, 5387.78448862045, 5390.1914712793005, 5390.487903649167, 3957.0700885291935, 4071.6131967463193, 5261.868453288679, 5513.0, 5736.827895163152, 5087.211482220262, 5619.4942455179025, 5668.404817494165, 5693.117566777156, 5695.202671625976, 5213.218017297436, 5214.348206474191, 5222.060029194743, 5246.344206974129, 5248.02911461379, 5026.924596131061, 5251.369835619712, 5259.552938000236, 5263.131583288753, 5274.604404669627, 11870.465829037628, 19367.225310987542, 19811.80188198114, 19883.602327953504, 20093.196272149242, 1974.9802501975084, 2097.8321734261376, 2136.9893150534303, 2148.387709502784, 2160.3734916874087, 8770.605322760492, 9340.439573625536, 9369.76575585609, 10942.960418760205, 11225.494852731646, 1720.750491178772, 1809.3938530592268, 1815.954601134969, 1816.4459839748872, 1829.1128802530761, 54351.72824135854, 56474.71762641201, 56764.71617641886, 58024.0, 58305.416945830846, 9793.118619324296, 9881.604735810488, 9913.900860991442, 9936.552855121392, 9980.101790838859, 12973.09188356806, 13120.737585248433, 13134.802977955338, 13143.474261029452, 13153.21080735159, 7207.531510451804, 7292.963535182396, 7299.05112335393, 7415.555066696015, 7450.292222238879, 6983.8603227935155, 7046.295370462913, 7057.258987806206, 7077.433805295564, 7126.643667816588, 4021.477207962946, 4310.741355518616, 4379.605835474823, 4406.911861762746, 4434.0, 1707.4706840879367, 1758.87687861851, 1833.6791061564172, 1834.1837882142318, 1851.8518518518486, 908.5638893331238, 934.289939645874, 939.6523286384082, 1044.4151275285712, 1061.2836335473678, 14285.0, 15134.318955647022, 15900.76148857768, 16066.43767468133, 16956.321747130223, 927.9396839205565, 934.7382732834817, 960.6349587156975, 968.3995922528078, 1006.3911333643186, 9390.85913711295, 9581.425114493153, 9914.40513569188, 9991.850122248172, 10203.897961020442, 487440.0, 496697.0, 539240.0, 547338.0, 571820.0, 56878.43121568731, 73664.26335736681, 73901.6304918472, 73981.63009184919, 75709.0, 1174.94712737927, 1175.3359351966283, 1209.9455524501418, 1226.0314351662266, 1248.6441364211157, 15124.54626361211, 15241.314140863466, 15381.923090384476, 15458.304376303318, 15684.764728528853, 33193.17017074592, 33251.50122748209, 33423.83288083544, 33645.66354336425, 33990.0, 42838.0, 44506.0, 45081.0, 47946.76026619845, 48000.519994801005, 6880.759173428906, 7076.018180197745, 7078.115235595551, 7275.090613673291, 7439.070116235471, 10840.970107839743, 10962.945185274342, 11295.830562541403, 11419.714507137389, 11546.94226528862, 9238.722838314861, 9239.72280831576, 9554.808903821746, 9629.422234665943, 9712.660056897974, 9487.905120948702, 9530.428174309563, 9583.760405989628, 10095.545700443645, 10123.797524049625, 9845.523171524328, 9962.452065136487, 10015.449150296803, 10060.849087263843, 10084.596616135566, 7220.675069621774, 7411.295926886937, 7429.4799364044, 7442.590657513889, 7470.6264686766535, 6706.329367063255, 9117.225035872025, 9156.0, 10151.086402223835, 10157.39055656663], "unit": "score", "name": "jquery.html", "value": 8120.048639862419}, {"lowerIsBetter": false, "replicates": [1325.039346473806, 1473.4474572035488, 1474.2333986327114, 1632.5836911587544, 1791.2118667786174, 6915.861682766348, 7481.02746642937, 7663.386929045677, 7691.192424795386, 7694.345980591656, 7606.163322034586, 7784.299413052824, 7790.688372465109, 7793.181715919818, 7793.415493837956, 2001.2095222387147, 2047.4164863014043, 2050.8769473831617, 2279.954400911985, 2312.144506532585, 2065.6901464780326, 2267.127156044918, 2304.331743794298, 2328.1967721136266, 2332.370260029791, 2214.9224777132804, 2256.1539422716482, 2264.53577016712, 2290.896909639062, 2293.2317673579373, 2211.2592281585526, 2235.564065007324, 2242.416971587391, 2245.8989345479495, 2266.161520237506, 2281.1217681192693, 2295.8163346932206, 2297.184499502669, 2299.528596637685, 2313.641385585237, 7528.47300688952, 7621.704310267268, 7626.046744156981, 7626.313631773111, 7629.618519074024, 4749.57253847152, 4842.903141937141, 4856.854294371175, 4873.951260487385, 4887.242477416006, 3150.3069324748517, 3209.293955329824, 3244.3024749678934, 3246.3020450603235, 3247.6589958054537, 1121.9551217951355, 1128.328644456547, 1130.4912789244872, 1132.9603463878725, 1224.5163160551533, 10600.0, 10616.946915265375, 10637.414942178177, 10661.147108231324, 10671.0, 4311.202427550913, 4385.51759306476, 4427.8228870844805, 4430.18041662287, 4474.530174331713, 9252.95373523128, 9262.30532710036, 9263.351565390492, 9265.166135047879, 9267.165955064076, 4859.101066302675, 4871.171900776805, 4897.583705385011, 4900.460949295574, 4903.828366007173, 4406.757628330409, 4410.779461026936, 4461.643068554507, 4466.285394336891, 4466.419365482531, 3538.7699799512948, 3619.2037751694584, 3756.0985363513105, 3840.1743625120175, 3869.187470631143, 1214.8420705308254, 1216.3796463803524, 1249.9625011249677, 1251.5119103549623, 1252.2048499203072, 1319.7492476429447, 1342.5502456677123, 1348.8651134886434, 1354.3634491788844, 1362.1350442468906, 7120.465965052538, 7422.257774222642, 7602.46782725204, 7609.6575654095695, 7612.543247405173, 1093.9179561532917, 1113.4599719136374, 1129.5764088466824, 1130.496928866663, 1142.493815631311, 5912.17229587858, 5954.910676339771, 6004.219451471281, 6005.069214271794, 6012.0, 8868.11318868108, 8894.555272236363, 8976.685815996409, 8979.46123232608, 9117.0, 8926.553672316359, 9017.233535149455, 9034.503102329303, 9035.412698174729, 9036.63853445868, 7055.729968605598, 7080.221175670672, 7209.206987231505, 7238.167610724729, 7241.710331586783, 7225.169105552718, 7273.709051637875, 7351.301626345488, 7358.66885990121, 7359.742409015659, 8364.707235246737, 8386.622601983048, 8595.570221488775, 8724.345674074597, 8745.606447709995, 8668.219860212612, 8771.605277762388, 8771.824563508566, 8916.28669706409, 8921.643134274556, 7120.0743903294315, 7193.712251509881, 7219.819504512429, 7222.349988501061, 7229.566226026455, 6599.505037122139, 6785.558938668971, 7167.139943206848, 7473.476856619985, 7552.66013029426, 7002.2297547268745, 7038.40173585251, 7081.18566364854, 7119.252478489684, 7388.889166662612, 7023.33278338557, 7091.184513780775, 7113.53762005468, 7187.209406965334, 7215.567065976058, 7187.101612298463, 7196.136463624399, 7223.061002069908, 7231.204567497676, 7263.0921134858145, 6430.0, 6579.440747536513, 6585.308542603149, 6587.209534855848, 6648.0, 6607.9669601651685, 6652.467802575879, 6658.400743933069, 6664.133662623828, 6675.165604299463], "unit": "score", "name": "mootools.html", "value": 4559.608075140053}, {"lowerIsBetter": false, "replicates": [329.5567461763928, 331.3968577189515, 337.7433150805389, 347.4718427989458, 352.5223322398152, 5628.718564071801, 5756.107803290486, 5772.682502462373, 5790.33411157717, 5798.0433228517295, 5536.695481748502, 5675.943240567593, 5684.346300175481, 5687.289088863892, 5739.770409183638, 4480.887977800565, 4483.148201841656, 4484.97757511212, 4488.640908727294, 4495.9325610115875, 4316.503602085753, 4378.299472084467, 4390.714603550759, 4474.284114541674, 4490.281554951209, 4411.382406463098, 4427.756473393962, 4436.600705936465, 4438.112377524491, 4440.955590444103, 4425.269830477967, 4435.556444355571, 4442.888927776815, 4444.622207112399, 4453.265211240141, 3910.491636087319, 3910.511186101737, 3918.1380096378753, 3920.6863450923856, 3922.235164142993, 5363.54409875161, 5489.64317319373, 5491.752871120769, 5499.642523236017, 5509.393966663663, 5106.744662766847, 5110.310108135429, 5114.181730923072, 5115.693058416469, 5118.155504341779, 6046.667433291167, 6049.909251361233, 6056.697165141725, 6060.727267272983, 6061.66660833654, 4151.97924010381, 4290.442242508485, 4291.24903141952, 4293.935590966138, 4303.8063287151845, 6030.698465076729, 6330.936690633081, 6408.03879418091, 6417.294097649255, 6427.967860160716, 4378.78106094694, 4393.209222339946, 4401.515833258339, 4402.713823601455, 4407.382966384709, 4454.933176002362, 4457.064016556495, 4463.174312752151, 4464.30803225494, 4470.195364834296, 5017.924731128963, 5108.182690769459, 5110.7955681773055, 5115.769790359443, 5119.718415487109, 6156.722947467375, 6157.476614487819, 6159.969200153971, 6163.167972323679, 6164.352742962014, 1568.741157708988, 1572.709048825971, 1578.3449868304754, 1578.3923189571867, 1579.3287852662572, 1067.8077945969644, 1081.1891081688734, 1081.6538707613645, 1086.5545126498098, 1086.706589220906, 5827.883442331215, 5832.154337621021, 5840.211571437886, 5852.297724273115, 5857.443542863506, 6307.873842523124, 6311.33730958252, 6321.051842223703, 6322.683865806691, 6324.71538780756, 5812.099124635688, 5832.358440571534, 5836.358000619928, 5840.707964601753, 5849.88300233993, 3255.4628486299493, 3389.5424117743787, 3393.6436674149354, 3394.287199688044, 3394.4229480988292, 6556.836079097965, 6564.4420224281475, 6570.967145164243, 6577.21073471177, 6596.373344532261, 6406.23125224976, 6454.774082907075, 6456.289808121103, 6456.870862582722, 6471.611703297817, 6471.288158302583, 6559.573627714279, 6615.801525954229, 6624.668766561749, 6639.601623902485, 6269.185005949197, 6330.8733825322315, 6332.11350410952, 6336.271328797247, 6338.749743841055, 6071.7571297147615, 6186.4741496973265, 6251.624902505864, 6275.623462592259, 6283.0, 6453.741850325934, 6591.176102987127, 6616.933830661632, 6630.801075967729, 6633.535652504278, 4315.892102697458, 4339.522652508158, 4342.478902531717, 4347.369631403492, 4348.652107831429, 6189.907151392643, 6316.05259211122, 6318.0, 6336.683165841781, 6338.524610654127, 6166.969165154145, 6172.660503672341, 6182.7217775201125, 6183.84540386494, 6187.783427580013, 6161.353057928853, 6161.383861613803, 6162.630242185483, 6164.137020817179, 6175.042868355412, 5945.494632956247, 6067.726952287069, 6070.726817293321, 6070.757169713162, 6081.148639190428, 6169.81490555284, 6195.4424101831055, 6198.318184999556, 6199.225096862892, 6209.503239740719, 5991.970040149771, 6012.368701286477, 6016.548758843017, 6017.939820601738, 6020.247469066367], "unit": "score", "name": "prototype.html", "value": 4640.7963156080905}, {"lowerIsBetter": false, "replicates": [770.7610640701383, 842.4187310755582, 849.1126772522717, 861.969831055913, 863.8747381629668, 13020.739585208303, 13276.535321263758, 13351.332433378317, 13356.198628082322, 13397.799033014513, 11923.344216068113, 12384.690382740437, 12468.563600273992, 12520.18618789778, 12546.059045571574, 665.7403612591081, 798.4929569723209, 811.0308181722844, 814.7433558429105, 815.1074573342181, 791.7070683846985, 793.8610743119959, 794.2772077409559, 796.4584082823677, 799.7760627024413, 692.8025512728873, 844.4300097434239, 845.3110714767445, 848.3001523742937, 849.2526576612603, 697.3897839390534, 699.0039194148344, 700.0898831519005, 700.8423104801429, 821.37575442664, 612.9540284478682, 615.0436071908181, 615.689077016104, 616.3897741236188, 616.4698359410903, 12889.291088990101, 12930.159539629894, 12942.482300707961, 12947.093703440763, 12967.481300747959, 12106.81839772404, 12402.689932751664, 12427.93786031064, 12491.687707807378, 12657.873421265762, 10236.129928956048, 10368.066873981377, 10381.273310868242, 10467.319624224401, 10671.253012289142, 3534.8586056557706, 3539.8938031859084, 3548.077499850032, 3574.267275208576, 3583.964160358389, 44812.55187448149, 44842.77578612119, 44912.77543612294, 45016.549834501566, 45142.54857451449, 9955.352902061342, 10030.648927287655, 10089.697309080593, 10112.063348371417, 10132.898671013343, 18232.179551920195, 18250.269989200282, 18280.26878924855, 18283.72574411385, 18296.817031829778, 7284.854302913912, 7482.8877566836545, 7582.317591416799, 7607.239276072459, 7714.228577142353, 4095.5904409559403, 4161.83352665896, 4261.31818908973, 4280.507741609755, 4307.396964424983, 2970.0495841331, 2994.431058098954, 2999.760019198459, 3007.368452624973, 3021.4108248891694, 545.4109561673383, 551.481607289147, 552.4861878453078, 561.9859503512445, 576.1904524143584, 594.4887396838715, 607.3683369295971, 654.5254690349553, 677.1704661789367, 699.8915168148945, 8552.61513231906, 9195.218406435528, 9226.26189904806, 9241.290361283183, 9665.806683866424, 542.8507160530886, 648.5265755998054, 656.5535435903631, 656.9343065693488, 710.6198183971551, 3821.407681809324, 3929.587393323717, 4143.08852052548, 4492.483364413069, 4505.7521836298665, 49156.262656060186, 49361.012779744204, 49463.0, 50073.0, 50369.0, 42721.57278427176, 43632.56367436285, 43753.56246437559, 43820.78089609532, 43850.561494385285, 40911.38632920509, 43215.0, 43456.0, 43850.561494385285, 44683.77658111689, 8532.530710810965, 8542.40203185771, 8694.17405346491, 8846.115388461103, 9088.545572721205, 30021.84989075128, 30418.0, 31173.37653246877, 31260.0, 31311.0, 39420.211595768495, 39771.80114099411, 40073.79963100166, 40483.59516404798, 40568.79715601403, 10308.742281443025, 10534.209934254808, 10638.127705519311, 10767.407792571485, 11425.428728563373, 12075.39623018828, 12247.877521224673, 12371.072169587496, 12467.314297713712, 12934.547290844775, 10207.0, 10644.520996555328, 10861.076808471369, 10861.78276434451, 11005.834912476159, 11395.829062564235, 11785.823212651645, 11867.109966752701, 11917.16579839403, 12198.329091899675, 10880.510377032893, 11378.43107844588, 11383.0, 11409.771804563696, 11423.543058277575, 9266.351355405057, 9542.713718588453, 9629.422234665943, 9630.374025688308, 9684.370515916444, 9296.95351523238, 9440.339176257596, 9512.09635084666, 9805.950970245103, 9867.45728984884], "unit": "score", "name": "yui.html", "value": 6135.881855009702}], "name": "dromaeo_css", "value": 6775.97398635514}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 109.0, 104.0, 108.0, 109.0, 110.0, 110.0, 110.0, 103.0, 110.0], "unit": "score", "name": "ai-astar", "value": 108.3}, {"lowerIsBetter": true, "replicates": [148.0, 124.0, 147.0, 164.0, 126.0, 152.0, 150.0, 138.0, 172.0, 132.0], "unit": "score", "name": "audio-beat-detection", "value": 145.3}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 161.0, 161.0, 163.0, 161.0, 161.0, 160.0, 162.0, 160.0], "unit": "score", "name": "audio-dft", "value": 161.2}, {"lowerIsBetter": true, "replicates": [74.0, 73.0, 129.0, 95.0, 73.0, 73.0, 72.0, 115.0, 90.0, 73.0], "unit": "score", "name": "audio-fft", "value": 86.7}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 141.0, 96.0, 95.0, 96.0, 148.0, 96.0, 95.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 109.7}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 110.0, 110.0, 109.0, 110.0, 109.0, 110.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.5}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 145.0, 146.0, 145.0, 146.0, 145.0, 146.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.4}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 97.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [57.0, 55.0, 55.0, 55.0, 55.0, 54.0, 55.0, 55.0, 54.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 54.8}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 68.0, 69.0, 69.0, 73.0, 69.0, 69.0, 69.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.2}, {"lowerIsBetter": true, "replicates": [88.0, 81.0, 83.0, 83.0, 84.0, 83.0, 83.0, 85.0, 90.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.2}, {"lowerIsBetter": true, "replicates": [120.0, 114.0, 117.0, 118.0, 113.0, 116.0, 122.0, 120.0, 122.0, 117.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 117.9}, {"lowerIsBetter": true, "replicates": [150.0, 151.0, 154.0, 138.0, 147.0, 136.0, 153.0, 154.0, 150.0, 148.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.1}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 67.0, 66.0, 67.0, 66.0, 66.0, 70.0, 66.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.9}], "name": "kraken", "value": 1503.3000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.98252981689905], "unit": "score", "name": "Richards", "value": 210.15280599999997}, {"lowerIsBetter": false, "replicates": [188.25301204819277], "unit": "score", "name": "DeltaBlue", "value": 351.2188160000002}, {"lowerIsBetter": false, "replicates": [279.87685418415896], "unit": "score", "name": "Encrypt", "value": 951.0647130000004}, {"lowerIsBetter": false, "replicates": [5273.684210526316], "unit": "score", "name": "Decrypt", "value": 50.47344311377245}, {"lowerIsBetter": false, "replicates": [1127.3957158962796], "unit": "score", "name": "RayTrace", "value": 656.370243}, {"lowerIsBetter": false, "replicates": [787.5688434303698], "unit": "score", "name": "Earley", "value": 846.228244755245}, {"lowerIsBetter": false, "replicates": [12395.061728395061], "unit": "score", "name": "Boyer", "value": 53.768429282868496}, {"lowerIsBetter": false, "replicates": [43416.666666666664], "unit": "score", "name": "RegExp", "value": 20.98238003838771}, {"lowerIsBetter": false, "replicates": [558.9714924538848], "unit": "score", "name": "Splay", "value": 145.78739899999994}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 20055.506552251285}]} 05:03:17 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,35]]", "result": "20055.51"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,35]]", "result": "1503.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,35]]", "result": "6775.98"}}} 05:03:17 INFO - Return code: 0 05:03:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 05:03:17 INFO - # TBPL SUCCESS # 05:03:17 INFO - Running post-action listener: _resource_record_post_action 05:03:17 INFO - Running post-run listener: _resource_record_post_run 05:03:18 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 20480; Write bytes: 538660864; Read time: 304; Write time: 542900 05:03:18 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 236011520; Read time: 0; Write time: 261348 05:03:18 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 20480; Write bytes: 302649344; Read time: 304; Write time: 281552 05:03:18 INFO - Running post-run listener: _upload_blobber_files 05:03:18 INFO - Blob upload gear active. 05:03:18 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 05:03:18 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:03:18 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', 'Mozilla-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 05:03:18 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 Mozilla-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 05:03:18 INFO - (blobuploader) - INFO - Open directory for files ... 05:03:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 05:03:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:03:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:03:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:03:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:03:19 INFO - (blobuploader) - INFO - Done attempting. 05:03:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:03:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:03:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:03:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:03:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:03:20 INFO - (blobuploader) - INFO - Done attempting. 05:03:20 INFO - (blobuploader) - INFO - Iteration through files over. 05:03:20 INFO - Return code: 0 05:03:20 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 05:03:20 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 05:03:20 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4262633d6551e715098f277b09d5ddf06fbb298666db5a968b04f63edd6eaa530896ada7484053ae206e22c41537077c0612d44c719acffac02c78b2a626629b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/85170933df1048519488f423f04371f7cd0a18026c62ce0a251144296928a30537a9b9341f0eeb0fe698b2faa74ce048b83ecfc9d9b37d5dee5ab2f55ae9ca77"} 05:03:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 05:03:20 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 05:03:20 INFO - Contents: 05:03:20 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4262633d6551e715098f277b09d5ddf06fbb298666db5a968b04f63edd6eaa530896ada7484053ae206e22c41537077c0612d44c719acffac02c78b2a626629b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/85170933df1048519488f423f04371f7cd0a18026c62ce0a251144296928a30537a9b9341f0eeb0fe698b2faa74ce048b83ecfc9d9b37d5dee5ab2f55ae9ca77"} 05:03:20 INFO - Running post-run listener: copy_logs_to_upload_dir 05:03:20 INFO - Copying logs to upload dir... 05:03:20 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 05:03:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.253250 ========= master_lag: 12.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-01-20 05:03:32.433340) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-20 05:03:32.437313) ========= 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=6d15e502d8e29d5d2676d664000001c3-1453293731.609659-1163643961 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4262633d6551e715098f277b09d5ddf06fbb298666db5a968b04f63edd6eaa530896ada7484053ae206e22c41537077c0612d44c719acffac02c78b2a626629b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/85170933df1048519488f423f04371f7cd0a18026c62ce0a251144296928a30537a9b9341f0eeb0fe698b2faa74ce048b83ecfc9d9b37d5dee5ab2f55ae9ca77"} build_url:https://queue.taskcluster.net/v1/task/aSnZ95h1Qcei6o3qrDDWCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011374 build_url: 'https://queue.taskcluster.net/v1/task/aSnZ95h1Qcei6o3qrDDWCA/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/Mozilla-Inbound/sha512/4262633d6551e715098f277b09d5ddf06fbb298666db5a968b04f63edd6eaa530896ada7484053ae206e22c41537077c0612d44c719acffac02c78b2a626629b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/85170933df1048519488f423f04371f7cd0a18026c62ce0a251144296928a30537a9b9341f0eeb0fe698b2faa74ce048b83ecfc9d9b37d5dee5ab2f55ae9ca77"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-20 05:03:32.462446) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 05:03:32.462783) ========= 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=6d15e502d8e29d5d2676d664000001c3-1453293731.609659-1163643961 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004582 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 05:03:32.512966) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-20 05:03:32.513279) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-20 05:03:32.513575) ========= ========= Total master_lag: 12.18 =========