builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-023 starttime: 1451443587.37 results: success (0) buildid: 20151229163003 builduid: 47a2d614b42849438be77521e2baefa7 revision: d2b5f30e0b9ce15285148c7c2dc944105bb0a48e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-29 18:46:27.369083) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-29 18:46:27.369523) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-29 18:46:27.369859) ========= 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=e10134013339c31d8d0c4708000001d6-1451437853.941506-235995808 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006303 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-29 18:46:27.402403) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-29 18:46:27.402692) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-29 18:46:27.450516) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 18:46:27.450779) ========= 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=e10134013339c31d8d0c4708000001d6-1451437853.941506-235995808 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004517 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 18:46:27.499773) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-29 18:46:27.500100) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-29 18:46:27.500478) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 18:46:27.500754) ========= 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=e10134013339c31d8d0c4708000001d6-1451437853.941506-235995808 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-29 18:46:28-- 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% 39.1M=0s 2015-12-29 18:46:28 (39.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.169354 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 18:46:27.683163) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 18:46:27.683486) ========= 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=e10134013339c31d8d0c4708000001d6-1451437853.941506-235995808 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015799 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 18:46:27.733018) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 18:46:27.733377) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev d2b5f30e0b9ce15285148c7c2dc944105bb0a48e --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 d2b5f30e0b9ce15285148c7c2dc944105bb0a48e --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=e10134013339c31d8d0c4708000001d6-1451437853.941506-235995808 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-29 18:46:28,523 truncating revision to first 12 chars 2015-12-29 18:46:28,523 Setting DEBUG logging. 2015-12-29 18:46:28,523 attempt 1/10 2015-12-29 18:46:28,523 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/d2b5f30e0b9c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-29 18:46:28,781 unpacking tar archive at: mozilla-inbound-d2b5f30e0b9c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.562831 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 18:46:28.308376) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-29 18:46:28.308642) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-29 18:46:28.319013) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-29 18:46:28.319256) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-29 18:46:28.319611) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2015-12-29 18:46:28.319882) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=e10134013339c31d8d0c4708000001d6-1451437853.941506-235995808 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:46:29 INFO - MultiFileLogger online at 20151229 18:46:29 in /builds/slave/test-pgo 18:46:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 18:46:29 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 18:46:29 INFO - {'append_to_log': False, 18:46:29 INFO - 'base_work_dir': '/builds/slave/test-pgo', 18:46:29 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 18:46:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 18:46:29 INFO - 'branch': 'Mozilla-Inbound', 18:46:29 INFO - 'buildbot_json_path': 'buildprops.json', 18:46:29 INFO - 'config_files': ('talos/linux_config.py',), 18:46:29 INFO - 'default_actions': ('clobber', 18:46:29 INFO - 'read-buildbot-config', 18:46:29 INFO - 'download-and-extract', 18:46:29 INFO - 'populate-webroot', 18:46:29 INFO - 'create-virtualenv', 18:46:29 INFO - 'install', 18:46:29 INFO - 'run-tests'), 18:46:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:46:29 INFO - 'download_minidump_stackwalk': True, 18:46:29 INFO - 'download_symbols': 'ondemand', 18:46:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:46:29 INFO - 'tooltool.py': '/tools/tooltool.py', 18:46:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:46:29 INFO - '/tools/misc-python/virtualenv.py')}, 18:46:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:46:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:46:29 INFO - 'installer_path': 'installer.exe', 18:46:29 INFO - 'log_level': 'info', 18:46:29 INFO - 'log_name': 'talos', 18:46:29 INFO - 'log_to_console': True, 18:46:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:46:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:46:29 INFO - 'opt_config_files': (), 18:46:29 INFO - 'pip_index': False, 18:46:29 INFO - 'sps_profile': False, 18:46:29 INFO - 'sps_profile_interval': 0, 18:46:29 INFO - 'suite': 'dromaeojs-e10s', 18:46:29 INFO - 'system_bits': '32', 18:46:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:46:29 INFO - 'title': 'talos-linux64-ix-023', 18:46:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:46:29 INFO - 'use_talos_json': True, 18:46:29 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 18:46:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:46:29 INFO - 'work_dir': 'build'} 18:46:29 INFO - ##### 18:46:29 INFO - ##### Running clobber step. 18:46:29 INFO - ##### 18:46:29 INFO - Running pre-action listener: _resource_record_pre_action 18:46:29 INFO - Running main action method: clobber 18:46:29 INFO - rmtree: /builds/slave/test-pgo/build 18:46:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 18:46:30 INFO - Running post-action listener: _resource_record_post_action 18:46:30 INFO - ##### 18:46:30 INFO - ##### Running read-buildbot-config step. 18:46:30 INFO - ##### 18:46:30 INFO - Running pre-action listener: _resource_record_pre_action 18:46:30 INFO - Running main action method: read_buildbot_config 18:46:30 INFO - Using buildbot properties: 18:46:30 INFO - { 18:46:30 INFO - "project": "", 18:46:30 INFO - "product": "firefox", 18:46:30 INFO - "script_repo_revision": "production", 18:46:30 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 18:46:30 INFO - "repository": "", 18:46:30 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 18:46:30 INFO - "buildid": "20151229163003", 18:46:30 INFO - "pgo_build": "True", 18:46:30 INFO - "basedir": "/builds/slave/test-pgo", 18:46:30 INFO - "buildnumber": 567, 18:46:30 INFO - "slavename": "talos-linux64-ix-023", 18:46:30 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:46:30 INFO - "platform": "ubuntu64_hw", 18:46:30 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 18:46:30 INFO - "branch": "mozilla-inbound", 18:46:30 INFO - "repo_path": "integration/mozilla-inbound", 18:46:30 INFO - "revision": "d2b5f30e0b9ce15285148c7c2dc944105bb0a48e", 18:46:30 INFO - "stage_platform": "linux64-pgo", 18:46:30 INFO - "builduid": "47a2d614b42849438be77521e2baefa7", 18:46:30 INFO - "slavebuilddir": "test" 18:46:30 INFO - } 18:46:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/QwSYiaiPRaqEL9f3cLz0Mg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 18:46:30 INFO - Running post-action listener: _resource_record_post_action 18:46:30 INFO - ##### 18:46:30 INFO - ##### Running download-and-extract step. 18:46:30 INFO - ##### 18:46:30 INFO - Running pre-action listener: _resource_record_pre_action 18:46:30 INFO - Running main action method: download_and_extract 18:46:30 INFO - mkdir: /builds/slave/test-pgo/build/tests 18:46:30 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')]} 18:46:30 INFO - https://queue.taskcluster.net/v1/task/QwSYiaiPRaqEL9f3cLz0Mg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 18:46:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QwSYiaiPRaqEL9f3cLz0Mg/artifacts/public/build/test_packages.json 18:46:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QwSYiaiPRaqEL9f3cLz0Mg/artifacts/public/build/test_packages.json 18:46:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QwSYiaiPRaqEL9f3cLz0Mg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 18:46:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QwSYiaiPRaqEL9f3cLz0Mg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 18:46:35 INFO - Downloaded 1302 bytes. 18:46:35 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 18:46:35 INFO - Using the following test package requirements: 18:46:35 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 18:46:35 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:46:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:46:35 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:46:35 INFO - u'jsshell-linux-x86_64.zip'], 18:46:35 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:46:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:46:35 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 18:46:35 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:46:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:46:35 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:46:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:46:35 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:46:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:46:35 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 18:46:35 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:46:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:46:35 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:46: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')]} 18:46:35 INFO - https://queue.taskcluster.net/v1/task/QwSYiaiPRaqEL9f3cLz0Mg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:46:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QwSYiaiPRaqEL9f3cLz0Mg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:46:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QwSYiaiPRaqEL9f3cLz0Mg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:46:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QwSYiaiPRaqEL9f3cLz0Mg/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 18:46:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QwSYiaiPRaqEL9f3cLz0Mg/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 18:46:37 INFO - Downloaded 23199604 bytes. 18:46:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 18:46:37 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:46:37 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 18:46:38 INFO - Return code: 0 18:46:38 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 18:46: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')]} 18:46:38 INFO - https://queue.taskcluster.net/v1/task/QwSYiaiPRaqEL9f3cLz0Mg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:46:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QwSYiaiPRaqEL9f3cLz0Mg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:46:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QwSYiaiPRaqEL9f3cLz0Mg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:46:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QwSYiaiPRaqEL9f3cLz0Mg/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 18:46:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QwSYiaiPRaqEL9f3cLz0Mg/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 18:46:40 INFO - Downloaded 23199604 bytes. 18:46:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 18:46:40 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:46:40 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 18:46:41 INFO - Return code: 0 18:46: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')]} 18:46:41 INFO - https://queue.taskcluster.net/v1/task/QwSYiaiPRaqEL9f3cLz0Mg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:46:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QwSYiaiPRaqEL9f3cLz0Mg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 18:46:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QwSYiaiPRaqEL9f3cLz0Mg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 18:46:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QwSYiaiPRaqEL9f3cLz0Mg/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 18:46:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QwSYiaiPRaqEL9f3cLz0Mg/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 18:46:42 INFO - Downloaded 11132270 bytes. 18:46:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 18:46:42 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 18:46:42 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 18:46:42 INFO - Return code: 0 18:46: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')]} 18:46:42 INFO - https://queue.taskcluster.net/v1/task/QwSYiaiPRaqEL9f3cLz0Mg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:46:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QwSYiaiPRaqEL9f3cLz0Mg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:46:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QwSYiaiPRaqEL9f3cLz0Mg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:46:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QwSYiaiPRaqEL9f3cLz0Mg/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 18:46:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QwSYiaiPRaqEL9f3cLz0Mg/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 18:46:43 INFO - Downloaded 54954166 bytes. 18:46:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QwSYiaiPRaqEL9f3cLz0Mg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:46:43 INFO - mkdir: /builds/slave/test-pgo/properties 18:46:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 18:46:43 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 18:46:43 INFO - Contents: 18:46:43 INFO - build_url:https://queue.taskcluster.net/v1/task/QwSYiaiPRaqEL9f3cLz0Mg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:46:43 INFO - Running post-action listener: _resource_record_post_action 18:46:43 INFO - Running post-action listener: set_extra_try_arguments 18:46:43 INFO - ##### 18:46:43 INFO - ##### Running populate-webroot step. 18:46:43 INFO - ##### 18:46:43 INFO - Running pre-action listener: _resource_record_pre_action 18:46:43 INFO - Running main action method: populate_webroot 18:46:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:46:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:46:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:46:43 INFO - '--tppagecycles', 18:46:43 INFO - '7'], 18:46:43 INFO - 'tests': ['tsvgm']}}, 18:46:43 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:46:43 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:46:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:46:43 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:46:43 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:46:43 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:46:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:46:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:46:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:46:43 INFO - 'talos_options': ['--e10s'], 18:46:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:46:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:46:43 INFO - 'tests': ['damp', 'tps']}, 18:46:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:46:43 INFO - 'talos_options': ['--e10s'], 18:46:43 INFO - 'tests': ['damp', 'tps']}, 18:46:43 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:46:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:46:43 INFO - 'other': {'tests': ['a11yr', 18:46:43 INFO - 'ts_paint', 18:46:43 INFO - 'tpaint', 18:46:43 INFO - 'sessionrestore', 18:46:43 INFO - 'sessionrestore_no_auto_restore']}, 18:46:43 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:46:43 INFO - 'tests': ['a11yr', 18:46:43 INFO - 'ts_paint', 18:46:43 INFO - 'tpaint', 18:46:43 INFO - 'sessionrestore', 18:46:43 INFO - 'sessionrestore_no_auto_restore']}, 18:46:43 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:46:43 INFO - 'tests': ['a11yr', 18:46:43 INFO - 'ts_paint', 18:46:43 INFO - 'tpaint', 18:46:43 INFO - 'sessionrestore', 18:46:43 INFO - 'sessionrestore_no_auto_restore']}, 18:46:43 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:46:43 INFO - 'tests': ['a11yr', 18:46:43 INFO - 'ts_paint', 18:46:43 INFO - 'tpaint', 18:46:43 INFO - 'sessionrestore', 18:46:43 INFO - 'sessionrestore_no_auto_restore']}, 18:46:43 INFO - 'other_l64': {'tests': ['a11yr', 18:46:43 INFO - 'ts_paint', 18:46:43 INFO - 'tpaint', 18:46:43 INFO - 'sessionrestore', 18:46:43 INFO - 'sessionrestore_no_auto_restore']}, 18:46:43 INFO - 'other_nol64': {'tests': ['a11yr', 18:46:43 INFO - 'ts_paint', 18:46:43 INFO - 'tpaint', 18:46:43 INFO - 'sessionrestore', 18:46:43 INFO - 'sessionrestore_no_auto_restore']}, 18:46:43 INFO - 'svgr': {'tests': ['tsvgx', 18:46:43 INFO - 'tsvgr_opacity', 18:46:43 INFO - 'tart', 18:46:43 INFO - 'tscrollx', 18:46:43 INFO - 'cart']}, 18:46:43 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:46:43 INFO - 'tests': ['tsvgx', 18:46:43 INFO - 'tsvgr_opacity', 18:46:43 INFO - 'tart', 18:46:43 INFO - 'tscrollx', 18:46:43 INFO - 'cart']}, 18:46:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:46:43 INFO - 'tests': ['tp5o']}, 18:46:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:46:43 INFO - 'talos_options': ['--e10s'], 18:46:43 INFO - 'tests': ['tp5o']}, 18:46:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:46:43 INFO - 'talos_options': ['--xperf_path', 18:46:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:46:43 INFO - 'tests': ['tp5n']}, 18:46:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:46:43 INFO - 'talos_options': ['--e10s', 18:46:43 INFO - '--xperf_path', 18:46:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:46:43 INFO - 'tests': ['tp5n']}}, 18:46:43 INFO - 'talos.zip': {'path': '', 18:46:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:46:43 INFO - Running post-action listener: _resource_record_post_action 18:46:43 INFO - ##### 18:46:43 INFO - ##### Running create-virtualenv step. 18:46:43 INFO - ##### 18:46:43 INFO - Running pre-action listener: _resource_record_pre_action 18:46:43 INFO - Running main action method: create_virtualenv 18:46:43 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 18:46:43 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 18:46:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 18:46:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:46:44 INFO - Using real prefix '/usr' 18:46:44 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 18:46:44 INFO - Installing distribute.............................................................................................................................................................................................done. 18:46:46 INFO - Installing pip.................done. 18:46:46 INFO - Return code: 0 18:46:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 18:46:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:46:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:46:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:46:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:46:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:46 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc8ecf7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1847230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d97f0>, '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 0x18452d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1845760>, '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': 'e10134013339c31d8d0c4708000001d6-1451437853.941506-235995808', '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 18:46:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 18:46:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:46:46 INFO - Using env: {'DISPLAY': ':0', 18:46:46 INFO - 'HOME': '/home/cltbld', 18:46:46 INFO - 'LANG': 'en_US.UTF-8', 18:46:46 INFO - 'LANGUAGE': 'en_US:en', 18:46:46 INFO - 'LOGNAME': 'cltbld', 18:46:46 INFO - 'MAIL': '/var/mail/cltbld', 18:46:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:46:46 INFO - 'MOZ_NO_REMOTE': '1', 18:46:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:46:46 INFO - 'NO_EM_RESTART': '1', 18:46:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:46:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:46:46 INFO - 'PWD': '/builds/slave/test-pgo', 18:46:46 INFO - 'SHELL': '/bin/bash', 18:46:46 INFO - 'SHLVL': '1', 18:46:46 INFO - 'TERM': 'linux', 18:46:46 INFO - 'TMOUT': '86400', 18:46:46 INFO - 'USER': 'cltbld', 18:46:46 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1451437853.941506-235995808', 18:46:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:46:46 INFO - '_': '/tools/buildbot/bin/python'} 18:46:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:46:46 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 18:46:46 INFO - Cleaning up... 18:46:46 INFO - Return code: 0 18:46:46 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 18:46:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:46:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:46:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:46:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:46:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:46 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fbc8ecf7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1847230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d97f0>, '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 0x18452d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1845760>, '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': 'e10134013339c31d8d0c4708000001d6-1451437853.941506-235995808', '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 18:46:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 18:46:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 18:46:46 INFO - Using env: {'DISPLAY': ':0', 18:46:46 INFO - 'HOME': '/home/cltbld', 18:46:46 INFO - 'LANG': 'en_US.UTF-8', 18:46:46 INFO - 'LANGUAGE': 'en_US:en', 18:46:46 INFO - 'LOGNAME': 'cltbld', 18:46:46 INFO - 'MAIL': '/var/mail/cltbld', 18:46:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:46:46 INFO - 'MOZ_NO_REMOTE': '1', 18:46:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:46:46 INFO - 'NO_EM_RESTART': '1', 18:46:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:46:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:46:46 INFO - 'PWD': '/builds/slave/test-pgo', 18:46:46 INFO - 'SHELL': '/bin/bash', 18:46:46 INFO - 'SHLVL': '1', 18:46:46 INFO - 'TERM': 'linux', 18:46:46 INFO - 'TMOUT': '86400', 18:46:46 INFO - 'USER': 'cltbld', 18:46:46 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1451437853.941506-235995808', 18:46:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:46:46 INFO - '_': '/tools/buildbot/bin/python'} 18:46:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:46:46 INFO - Downloading/unpacking psutil>=0.7.1 18:46: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 18:46: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 18:46: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 18:46: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 18:46: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 18:46: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 18:46:48 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 18:46:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 18:46:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 18:46:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:46:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:46:48 INFO - Installing collected packages: psutil 18:46:48 INFO - Running setup.py install for psutil 18:46:48 INFO - building 'psutil._psutil_linux' extension 18:46:48 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 18:46:49 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 18:46:49 INFO - building 'psutil._psutil_posix' extension 18:46:49 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 18:46:49 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 18:46:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:46:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:46:49 INFO - Successfully installed psutil 18:46:49 INFO - Cleaning up... 18:46:49 INFO - Return code: 0 18:46:49 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 18:46:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:46:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:46:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:46:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:46:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:49 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fbc8ecf7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1847230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d97f0>, '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 0x18452d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1845760>, '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': 'e10134013339c31d8d0c4708000001d6-1451437853.941506-235995808', '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 18:46:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 18:46:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 18:46:49 INFO - Using env: {'DISPLAY': ':0', 18:46:49 INFO - 'HOME': '/home/cltbld', 18:46:49 INFO - 'LANG': 'en_US.UTF-8', 18:46:49 INFO - 'LANGUAGE': 'en_US:en', 18:46:49 INFO - 'LOGNAME': 'cltbld', 18:46:49 INFO - 'MAIL': '/var/mail/cltbld', 18:46:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:46:49 INFO - 'MOZ_NO_REMOTE': '1', 18:46:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:46:49 INFO - 'NO_EM_RESTART': '1', 18:46:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:46:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:46:49 INFO - 'PWD': '/builds/slave/test-pgo', 18:46:49 INFO - 'SHELL': '/bin/bash', 18:46:49 INFO - 'SHLVL': '1', 18:46:49 INFO - 'TERM': 'linux', 18:46:49 INFO - 'TMOUT': '86400', 18:46:49 INFO - 'USER': 'cltbld', 18:46:49 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1451437853.941506-235995808', 18:46:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:46:49 INFO - '_': '/tools/buildbot/bin/python'} 18:46:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:46:49 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:46:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:46:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:46:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:46:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:46:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:46:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:46:51 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:46:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 18:46:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:46:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:46:51 INFO - Installing collected packages: mozsystemmonitor 18:46:51 INFO - Running setup.py install for mozsystemmonitor 18:46:51 INFO - Successfully installed mozsystemmonitor 18:46:51 INFO - Cleaning up... 18:46:51 INFO - Return code: 0 18:46:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 18:46:51 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')]} 18:46:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:46:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:51 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')]} 18:46:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:46:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:51 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc8ecf7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1847230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d97f0>, '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 0x18452d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1845760>, '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': 'e10134013339c31d8d0c4708000001d6-1451437853.941506-235995808', '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 18:46:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 18:46:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:46:51 INFO - Using env: {'DISPLAY': ':0', 18:46:51 INFO - 'HOME': '/home/cltbld', 18:46:51 INFO - 'LANG': 'en_US.UTF-8', 18:46:51 INFO - 'LANGUAGE': 'en_US:en', 18:46:51 INFO - 'LOGNAME': 'cltbld', 18:46:51 INFO - 'MAIL': '/var/mail/cltbld', 18:46:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:46:51 INFO - 'MOZ_NO_REMOTE': '1', 18:46:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:46:51 INFO - 'NO_EM_RESTART': '1', 18:46:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:46:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:46:51 INFO - 'PWD': '/builds/slave/test-pgo', 18:46:51 INFO - 'SHELL': '/bin/bash', 18:46:51 INFO - 'SHLVL': '1', 18:46:51 INFO - 'TERM': 'linux', 18:46:51 INFO - 'TMOUT': '86400', 18:46:51 INFO - 'USER': 'cltbld', 18:46:51 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1451437853.941506-235995808', 18:46:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:46:51 INFO - '_': '/tools/buildbot/bin/python'} 18:46:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:46:51 INFO - Downloading/unpacking blobuploader==1.2.4 18:46:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:46:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:46:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:46:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:46:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:46:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:46:53 INFO - Downloading blobuploader-1.2.4.tar.gz 18:46:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 18:46:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:46:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:46:53 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 18:46:53 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 18:46:53 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 18:46:53 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 18:46:53 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 18:46:53 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 18:46:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 18:46:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 18:46:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:46:53 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 18:46:53 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 18:46:53 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 18:46:53 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 18:46:53 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 18:46:53 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 18:46:53 INFO - Downloading docopt-0.6.1.tar.gz 18:46:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 18:46:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 18:46:54 INFO - Installing collected packages: blobuploader, requests, docopt 18:46:54 INFO - Running setup.py install for blobuploader 18:46:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:46:54 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 18:46:54 INFO - Running setup.py install for requests 18:46:54 INFO - Running setup.py install for docopt 18:46:54 INFO - Successfully installed blobuploader requests docopt 18:46:54 INFO - Cleaning up... 18:46:54 INFO - Return code: 0 18:46:54 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:46:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:46:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:46:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:46:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:46:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:54 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc8ecf7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1847230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d97f0>, '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 0x18452d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1845760>, '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': 'e10134013339c31d8d0c4708000001d6-1451437853.941506-235995808', '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 18:46:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 18:46:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:46:54 INFO - Using env: {'DISPLAY': ':0', 18:46:54 INFO - 'HOME': '/home/cltbld', 18:46:54 INFO - 'LANG': 'en_US.UTF-8', 18:46:54 INFO - 'LANGUAGE': 'en_US:en', 18:46:54 INFO - 'LOGNAME': 'cltbld', 18:46:54 INFO - 'MAIL': '/var/mail/cltbld', 18:46:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:46:54 INFO - 'MOZ_NO_REMOTE': '1', 18:46:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:46:54 INFO - 'NO_EM_RESTART': '1', 18:46:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:46:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:46:54 INFO - 'PWD': '/builds/slave/test-pgo', 18:46:54 INFO - 'SHELL': '/bin/bash', 18:46:54 INFO - 'SHLVL': '1', 18:46:54 INFO - 'TERM': 'linux', 18:46:54 INFO - 'TMOUT': '86400', 18:46:54 INFO - 'USER': 'cltbld', 18:46:54 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1451437853.941506-235995808', 18:46:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:46:54 INFO - '_': '/tools/buildbot/bin/python'} 18:46:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:46:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:46:54 INFO - Running setup.py (path:/tmp/pip-uqYmvX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:46:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:46:54 INFO - Running setup.py (path:/tmp/pip-LLLhIs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:46:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:46:54 INFO - Running setup.py (path:/tmp/pip-CZediH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:46:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:46:55 INFO - Running setup.py (path:/tmp/pip-9WoCiz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:46:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 18:46:55 INFO - Running setup.py (path:/tmp/pip-SOTn5b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 18:46:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:46:55 INFO - Running setup.py (path:/tmp/pip-bVfxit-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:46:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:46:55 INFO - Running setup.py (path:/tmp/pip-bx1ZVB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:46:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:46:55 INFO - Running setup.py (path:/tmp/pip-v5hoyt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:46:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 18:46:55 INFO - Running setup.py (path:/tmp/pip-tekjCi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 18:46:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 18:46:55 INFO - Running setup.py (path:/tmp/pip-4yViGd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 18:46:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:46:55 INFO - Running setup.py (path:/tmp/pip-f7Q1wY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:46:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:46:55 INFO - Running setup.py (path:/tmp/pip-5bupHo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:46:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:46:55 INFO - Running setup.py (path:/tmp/pip-LAilW7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:46:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:46:55 INFO - Running setup.py (path:/tmp/pip-EoZN7c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:46:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:46:55 INFO - Running setup.py (path:/tmp/pip-sLzoAK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:46:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 18:46:55 INFO - Running setup.py (path:/tmp/pip-ETfeG3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 18:46:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 18:46:55 INFO - Running setup.py (path:/tmp/pip-eiveOz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 18:46:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:46:56 INFO - Running setup.py install for manifestparser 18:46:56 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 18:46:56 INFO - Running setup.py install for mozcrash 18:46:56 INFO - Running setup.py install for mozdebug 18:46:56 INFO - Running setup.py install for mozdevice 18:46:56 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 18:46:56 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 18:46:56 INFO - Running setup.py install for mozfile 18:46:56 INFO - Running setup.py install for mozhttpd 18:46:56 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 18:46:56 INFO - Running setup.py install for mozinfo 18:46:56 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 18:46:56 INFO - Running setup.py install for mozInstall 18:46:56 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 18:46:56 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 18:46:56 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 18:46:56 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 18:46:56 INFO - Running setup.py install for mozleak 18:46:56 INFO - Running setup.py install for mozlog 18:46:57 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 18:46:57 INFO - Running setup.py install for moznetwork 18:46:57 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 18:46:57 INFO - Running setup.py install for mozprocess 18:46:57 INFO - Running setup.py install for mozprofile 18:46:57 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 18:46:57 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 18:46:57 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 18:46:57 INFO - Running setup.py install for mozrunner 18:46:57 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 18:46:57 INFO - Running setup.py install for mozscreenshot 18:46:57 INFO - Running setup.py install for moztest 18:46:57 INFO - Running setup.py install for mozversion 18:46:57 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 18:46:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:46:57 INFO - Cleaning up... 18:46:57 INFO - Return code: 0 18:46:57 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:46:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:46:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:46:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:46:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:46:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc8ecf7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1847230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d97f0>, '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 0x18452d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1845760>, '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': 'e10134013339c31d8d0c4708000001d6-1451437853.941506-235995808', '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 18:46:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 18:46:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:46:57 INFO - Using env: {'DISPLAY': ':0', 18:46:57 INFO - 'HOME': '/home/cltbld', 18:46:57 INFO - 'LANG': 'en_US.UTF-8', 18:46:57 INFO - 'LANGUAGE': 'en_US:en', 18:46:57 INFO - 'LOGNAME': 'cltbld', 18:46:57 INFO - 'MAIL': '/var/mail/cltbld', 18:46:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:46:57 INFO - 'MOZ_NO_REMOTE': '1', 18:46:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:46:57 INFO - 'NO_EM_RESTART': '1', 18:46:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:46:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:46:57 INFO - 'PWD': '/builds/slave/test-pgo', 18:46:57 INFO - 'SHELL': '/bin/bash', 18:46:57 INFO - 'SHLVL': '1', 18:46:57 INFO - 'TERM': 'linux', 18:46:57 INFO - 'TMOUT': '86400', 18:46:57 INFO - 'USER': 'cltbld', 18:46:57 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1451437853.941506-235995808', 18:46:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:46:57 INFO - '_': '/tools/buildbot/bin/python'} 18:46:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:46:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:46:58 INFO - Running setup.py (path:/tmp/pip-xBhyZS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:46:58 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)) 18:46:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:46:58 INFO - Running setup.py (path:/tmp/pip-ovjQ22-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:46:58 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)) 18:46:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:46:58 INFO - Running setup.py (path:/tmp/pip-w6iSmv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:46:58 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)) 18:46:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:46:58 INFO - Running setup.py (path:/tmp/pip-60hEZX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:46:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 18:46:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 18:46:58 INFO - Running setup.py (path:/tmp/pip-OlzGfC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 18:46:58 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)) 18:46:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:46:58 INFO - Running setup.py (path:/tmp/pip-xoSNsu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:46:58 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)) 18:46:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:46:58 INFO - Running setup.py (path:/tmp/pip-qEdVEG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:46:58 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)) 18:46:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:46:58 INFO - Running setup.py (path:/tmp/pip-pATP_o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:46:58 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)) 18:46:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 18:46:58 INFO - Running setup.py (path:/tmp/pip-yEuV24-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 18:46:58 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)) 18:46:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 18:46:58 INFO - Running setup.py (path:/tmp/pip-erf4kU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 18:46:58 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)) 18:46:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:46:58 INFO - Running setup.py (path:/tmp/pip-VzG7GG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:46:58 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)) 18:46:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:46:58 INFO - Running setup.py (path:/tmp/pip-ZAwpvc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:46:58 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)) 18:46:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:46:58 INFO - Running setup.py (path:/tmp/pip-LwwGSz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:46:59 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)) 18:46:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:46:59 INFO - Running setup.py (path:/tmp/pip-dMI5vC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:46:59 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)) 18:46:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:46:59 INFO - Running setup.py (path:/tmp/pip-dGE9LR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:46:59 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)) 18:46:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 18:46:59 INFO - Running setup.py (path:/tmp/pip-SdHXdQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 18:46:59 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)) 18:46:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 18:46:59 INFO - Running setup.py (path:/tmp/pip-GYTpoE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 18:46:59 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)) 18:46:59 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)) 18:46:59 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)) 18:46:59 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)) 18:46:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 18:46:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 18:46:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 18:46:59 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 18:46:59 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 18:46:59 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 18:46:59 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 18:46:59 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 18:46:59 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 18:47:00 INFO - Downloading blessings-1.5.1.tar.gz 18:47:00 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 18:47:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 18:47:01 INFO - Installing collected packages: blessings 18:47:01 INFO - Running setup.py install for blessings 18:47:01 INFO - Successfully installed blessings 18:47:01 INFO - Cleaning up... 18:47:01 INFO - Return code: 0 18:47:01 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 18:47:01 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:47:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:47:01 INFO - Reading from file tmpfile_stdout 18:47:01 INFO - Current package versions: 18:47:01 INFO - argparse == 1.2.1 18:47:01 INFO - blessings == 1.5.1 18:47:01 INFO - blobuploader == 1.2.4 18:47:01 INFO - docopt == 0.6.1 18:47:01 INFO - manifestparser == 1.1 18:47:01 INFO - mozInstall == 1.12 18:47:01 INFO - mozcrash == 0.16 18:47:01 INFO - mozdebug == 0.1 18:47:01 INFO - mozdevice == 0.47 18:47:01 INFO - mozfile == 1.2 18:47:01 INFO - mozhttpd == 0.7 18:47:01 INFO - mozinfo == 0.9 18:47:01 INFO - mozleak == 0.1 18:47:01 INFO - mozlog == 3.1 18:47:01 INFO - moznetwork == 0.27 18:47:01 INFO - mozprocess == 0.22 18:47:01 INFO - mozprofile == 0.28 18:47:01 INFO - mozrunner == 6.11 18:47:01 INFO - mozscreenshot == 0.1 18:47:01 INFO - mozsystemmonitor == 0.0 18:47:01 INFO - moztest == 0.7 18:47:01 INFO - mozversion == 1.4 18:47:01 INFO - psutil == 3.1.1 18:47:01 INFO - requests == 1.2.3 18:47:01 INFO - wsgiref == 0.1.2 18:47:01 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:47:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:47:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:47:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:47:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:47:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7fbc8ecf7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1847230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d97f0>, '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 0x18452d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1845760>, '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': 'e10134013339c31d8d0c4708000001d6-1451437853.941506-235995808', '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 18:47:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 18:47:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:47:01 INFO - Using env: {'DISPLAY': ':0', 18:47:01 INFO - 'HOME': '/home/cltbld', 18:47:01 INFO - 'LANG': 'en_US.UTF-8', 18:47:01 INFO - 'LANGUAGE': 'en_US:en', 18:47:01 INFO - 'LOGNAME': 'cltbld', 18:47:01 INFO - 'MAIL': '/var/mail/cltbld', 18:47:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:47:01 INFO - 'MOZ_NO_REMOTE': '1', 18:47:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:47:01 INFO - 'NO_EM_RESTART': '1', 18:47:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:47:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:47:01 INFO - 'PWD': '/builds/slave/test-pgo', 18:47:01 INFO - 'SHELL': '/bin/bash', 18:47:01 INFO - 'SHLVL': '1', 18:47:01 INFO - 'TERM': 'linux', 18:47:01 INFO - 'TMOUT': '86400', 18:47:01 INFO - 'USER': 'cltbld', 18:47:01 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1451437853.941506-235995808', 18:47:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:47:01 INFO - '_': '/tools/buildbot/bin/python'} 18:47:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:47:01 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)) 18:47:01 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)) 18:47:01 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)) 18:47:01 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)) 18:47:01 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)) 18:47:01 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)) 18:47:01 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)) 18:47:01 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)) 18:47:01 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)) 18:47:01 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)) 18:47:01 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)) 18:47:01 INFO - Cleaning up... 18:47:01 INFO - Return code: 0 18:47:01 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 18:47:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:47:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:47:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:47:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:47:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc8ecf7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1847230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d97f0>, '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 0x18452d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1845760>, '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': 'e10134013339c31d8d0c4708000001d6-1451437853.941506-235995808', '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 18:47:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 18:47:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:47:01 INFO - Using env: {'DISPLAY': ':0', 18:47:01 INFO - 'HOME': '/home/cltbld', 18:47:01 INFO - 'LANG': 'en_US.UTF-8', 18:47:01 INFO - 'LANGUAGE': 'en_US:en', 18:47:01 INFO - 'LOGNAME': 'cltbld', 18:47:01 INFO - 'MAIL': '/var/mail/cltbld', 18:47:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:47:01 INFO - 'MOZ_NO_REMOTE': '1', 18:47:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:47:01 INFO - 'NO_EM_RESTART': '1', 18:47:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:47:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:47:01 INFO - 'PWD': '/builds/slave/test-pgo', 18:47:01 INFO - 'SHELL': '/bin/bash', 18:47:01 INFO - 'SHLVL': '1', 18:47:01 INFO - 'TERM': 'linux', 18:47:01 INFO - 'TMOUT': '86400', 18:47:01 INFO - 'USER': 'cltbld', 18:47:01 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1451437853.941506-235995808', 18:47:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:47:01 INFO - '_': '/tools/buildbot/bin/python'} 18:47:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:47:01 INFO - Downloading/unpacking jsonschema 18:47:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:47:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 18:47:03 INFO - Downloading/unpacking functools32 (from jsonschema) 18:47:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:03 INFO - Downloading functools32-3.2.3-2.tar.gz 18:47:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 18:47:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 18:47:03 INFO - warning: no files found matching '*.txt' 18:47:03 INFO - no previously-included directories found matching 'build' 18:47:03 INFO - no previously-included directories found matching 'dist' 18:47:03 INFO - no previously-included directories found matching '.git*' 18:47:03 INFO - Installing collected packages: jsonschema, functools32 18:47:03 INFO - Running setup.py install for functools32 18:47:03 INFO - warning: no files found matching '*.txt' 18:47:03 INFO - no previously-included directories found matching 'build' 18:47:03 INFO - no previously-included directories found matching 'dist' 18:47:03 INFO - no previously-included directories found matching '.git*' 18:47:04 INFO - Successfully installed jsonschema functools32 18:47:04 INFO - Cleaning up... 18:47:04 INFO - Return code: 0 18:47:04 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 18:47:04 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')]} 18:47:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:47:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:04 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')]} 18:47:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:47:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:04 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc8ecf7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1847230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d97f0>, '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 0x18452d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1845760>, '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': 'e10134013339c31d8d0c4708000001d6-1451437853.941506-235995808', '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 18:47:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 18:47:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 18:47:04 INFO - Using env: {'DISPLAY': ':0', 18:47:04 INFO - 'HOME': '/home/cltbld', 18:47:04 INFO - 'LANG': 'en_US.UTF-8', 18:47:04 INFO - 'LANGUAGE': 'en_US:en', 18:47:04 INFO - 'LOGNAME': 'cltbld', 18:47:04 INFO - 'MAIL': '/var/mail/cltbld', 18:47:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:47:04 INFO - 'MOZ_NO_REMOTE': '1', 18:47:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:47:04 INFO - 'NO_EM_RESTART': '1', 18:47:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:47:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:47:04 INFO - 'PWD': '/builds/slave/test-pgo', 18:47:04 INFO - 'SHELL': '/bin/bash', 18:47:04 INFO - 'SHLVL': '1', 18:47:04 INFO - 'TERM': 'linux', 18:47:04 INFO - 'TMOUT': '86400', 18:47:04 INFO - 'USER': 'cltbld', 18:47:04 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1451437853.941506-235995808', 18:47:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:47:04 INFO - '_': '/tools/buildbot/bin/python'} 18:47:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:47:04 INFO - Downloading/unpacking flake8 18:47:04 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 18:47:04 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 18:47:04 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 18:47:04 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 18:47:04 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 18:47:04 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 18:47:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:47:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 18:47:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:47:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:47:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 18:47:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:47:06 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 18:47:06 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 18:47:06 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 18:47:06 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 18:47:06 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 18:47:06 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 18:47:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 18:47:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:47:06 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 18:47:06 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 18:47:06 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 18:47:06 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 18:47:06 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 18:47:06 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 18:47:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 18:47:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 18:47:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:47:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:47:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:47:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:47:06 INFO - no previously-included directories found matching 'docs/_build' 18:47:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:47:06 INFO - Running setup.py install for pep8 18:47:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:47:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:47:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:47:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:47:06 INFO - no previously-included directories found matching 'docs/_build' 18:47:06 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 18:47:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:47:06 INFO - Cleaning up... 18:47:06 INFO - Return code: 0 18:47:06 INFO - Running post-action listener: _resource_record_post_action 18:47:06 INFO - Running post-action listener: _start_resource_monitoring 18:47:06 INFO - Starting resource monitoring. 18:47:06 INFO - ##### 18:47:06 INFO - ##### Running install step. 18:47:06 INFO - ##### 18:47:06 INFO - Running pre-action listener: _resource_record_pre_action 18:47:06 INFO - Running main action method: install 18:47:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:47:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:47:07 INFO - Reading from file tmpfile_stdout 18:47:07 INFO - Detecting whether we're running mozinstall >=1.0... 18:47:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 18:47:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 18:47:07 INFO - Reading from file tmpfile_stdout 18:47:07 INFO - Output received: 18:47:07 INFO - Usage: mozinstall [options] installer 18:47:07 INFO - Options: 18:47:07 INFO - -h, --help show this help message and exit 18:47:07 INFO - -d DEST, --destination=DEST 18:47:07 INFO - Directory to install application into. [default: 18:47:07 INFO - "/builds/slave/test-pgo"] 18:47:07 INFO - --app=APP Application being installed. [default: firefox] 18:47:07 INFO - mkdir: /builds/slave/test-pgo/build/application 18:47:07 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'] 18:47:07 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 18:47:23 INFO - Reading from file tmpfile_stdout 18:47:23 INFO - Output received: 18:47:23 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 18:47:23 INFO - Running post-action listener: _resource_record_post_action 18:47:23 INFO - ##### 18:47:23 INFO - ##### Running run-tests step. 18:47:23 INFO - ##### 18:47:23 INFO - Running pre-action listener: _resource_record_pre_action 18:47:23 INFO - Running main action method: run_tests 18:47:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 18:47:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 18:47:23 INFO - Python 2.7.3 18:47:23 INFO - Return code: 0 18:47:23 INFO - grabbing minidump binary from tooltool 18:47:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:47:23 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 0x18d97f0>, '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 0x18452d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1845760>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 18:47:23 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 18:47:23 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 18:47:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:47:23 INFO - Return code: 0 18:47:23 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 18:47:23 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 18:47:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 18:47:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 18:47:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 18:47:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 18:47:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 18:47:24 INFO - Return code: 0 18:47:24 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-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QwSYiaiPRaqEL9f3cLz0Mg/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-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 18:47:24 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-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QwSYiaiPRaqEL9f3cLz0Mg/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-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 18:47:24 INFO - Using env: {'DISPLAY': ':0', 18:47:24 INFO - 'HOME': '/home/cltbld', 18:47:24 INFO - 'LANG': 'en_US.UTF-8', 18:47:24 INFO - 'LANGUAGE': 'en_US:en', 18:47:24 INFO - 'LOGNAME': 'cltbld', 18:47:24 INFO - 'MAIL': '/var/mail/cltbld', 18:47:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:47:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 18:47:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:47:24 INFO - 'MOZ_NO_REMOTE': '1', 18:47:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:47:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:47:24 INFO - 'NO_EM_RESTART': '1', 18:47:24 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:47:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:47:24 INFO - 'PWD': '/builds/slave/test-pgo', 18:47:24 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 18:47:24 INFO - 'SHELL': '/bin/bash', 18:47:24 INFO - 'SHLVL': '1', 18:47:24 INFO - 'TERM': 'linux', 18:47:24 INFO - 'TMOUT': '86400', 18:47:24 INFO - 'USER': 'cltbld', 18:47:24 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1451437853.941506-235995808', 18:47:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:47:24 INFO - '_': '/tools/buildbot/bin/python'} 18:47:24 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-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QwSYiaiPRaqEL9f3cLz0Mg/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-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 18:47:24 INFO - mozversion application_buildid: 20151229163003 18:47:24 INFO - mozversion application_changeset: d2b5f30e0b9ce15285148c7c2dc944105bb0a48e 18:47:24 INFO - mozversion application_display_name: Nightly 18:47:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:47:24 INFO - mozversion application_name: Firefox 18:47:24 INFO - mozversion application_remotingname: firefox 18:47:24 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 18:47:24 INFO - mozversion application_vendor: Mozilla 18:47:24 INFO - mozversion application_version: 46.0a1 18:47:24 INFO - mozversion platform_buildid: 20151229163003 18:47:24 INFO - mozversion platform_changeset: d2b5f30e0b9ce15285148c7c2dc944105bb0a48e 18:47:24 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 18:47:24 INFO - mozversion platform_version: 46.0a1 18:47:24 INFO - using testdate: 1451443644 18:47:24 INFO - actual date: 1451443644 18:47:24 INFO - starting webserver on 'localhost:35334' 18:47:24 INFO - SUITE-START | Running 3 tests 18:47:24 INFO - TEST-START | dromaeo_css 18:47:24 INFO - operating with platform_type : linux_ 18:47:24 INFO - Initialising browser for dromaeo_css test... 18:47:24 INFO - TEST-INFO | started process 3442 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpAYUj0B/profile http://localhost:35334/getInfo.html) 18:47:25 INFO - PROCESS | 3442 | Failed to load Oculus VR library! 18:47:28 INFO - PROCESS | 3442 | Failed to load Oculus VR library! 18:47:29 INFO - PROCESS | 3442 | __metrics Screen width/height:1600/1200 18:47:29 INFO - PROCESS | 3442 | colorDepth:24 18:47:29 INFO - PROCESS | 3442 | Browser inner width/height: 1024/697 18:47:29 INFO - PROCESS | 3442 | __metrics 18:47:29 INFO - PROCESS | 3442 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 18:47:30 INFO - TEST-INFO | 3442: exit 0 18:47:30 INFO - Browser initialized. 18:47:30 INFO - Running cycle 1/1 for dromaeo_css test... 18:47:30 INFO - TEST-INFO | started process 3576 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpAYUj0B/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:47:30 INFO - PROCESS | 3576 | Failed to load Oculus VR library! 18:47:31 INFO - PROCESS | 3576 | Failed to load Oculus VR library! 18:47:42 INFO - PROCESS | 3576 | RSS: Main: 148852736 18:47:42 INFO - PROCESS | 3576 | 18:48:31 INFO - PROCESS | 3576 | 1451443711617 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] 18:50:40 INFO - PROCESS | 3576 | Cycle 1(1): loaded http://localhost:35334/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35334/tests/dromaeo/cssquery-ext.html) 18:50:41 INFO - PROCESS | 3576 | RSS: Main: 157356032 18:50:41 INFO - PROCESS | 3576 | 18:53:43 INFO - PROCESS | 3576 | Cycle 1(1): loaded http://localhost:35334/tests/dromaeo/cssquery-ext.html (next: http://localhost:35334/tests/dromaeo/cssquery-jquery.html) 18:53:44 INFO - PROCESS | 3576 | RSS: Main: 154415104 18:53:44 INFO - PROCESS | 3576 | 18:56:46 INFO - PROCESS | 3576 | Cycle 1(1): loaded http://localhost:35334/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35334/tests/dromaeo/cssquery-mootools.html) 18:56:46 INFO - PROCESS | 3576 | RSS: Main: 152924160 18:56:46 INFO - PROCESS | 3576 | 18:59:48 INFO - PROCESS | 3576 | Cycle 1(1): loaded http://localhost:35334/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35334/tests/dromaeo/cssquery-prototype.html) 18:59:49 INFO - PROCESS | 3576 | RSS: Main: 150843392 18:59:49 INFO - PROCESS | 3576 | 19:02:51 INFO - PROCESS | 3576 | Cycle 1(1): loaded http://localhost:35334/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35334/tests/dromaeo/cssquery-yui.html) 19:02:52 INFO - PROCESS | 3576 | RSS: Main: 153513984 19:02:52 INFO - PROCESS | 3576 | 19:05:54 INFO - PROCESS | 3576 | Cycle 1(1): loaded http://localhost:35334/tests/dromaeo/cssquery-yui.html (next: http://localhost:35334/tests/dromaeo/cssquery-dojo.html) 19:05:54 INFO - PROCESS | 3576 | RSS: Main: 154718208 19:05:54 INFO - PROCESS | 3576 | 19:05:54 INFO - PROCESS | 3576 | __start_tp_report 19:05:54 INFO - PROCESS | 3576 | _x_x_mozilla_page_load 19:05:54 INFO - PROCESS | 3576 | _x_x_mozilla_page_load_details 19:05:54 INFO - PROCESS | 3576 | |i|pagename|runs| 19:05:54 INFO - PROCESS | 3576 | |0;dojo.html;3193.5050067239576;3245.6267529234146;3277.6394596594387;3297.2745995880896;3299.1752061984503;5186.351706036746;5252.238425428315;5257.13257312543;5338.0658384782655;5345.1982202669615;5293.285406470125;5311.62818602698;5359.464053594648;5410.2966614340085;5413.783448662059;4826.951730482685;4853.902921941559;4921.876953076166;4926.5812405945535;4981.676191047589;4967.379077615298;5001.14980453322;5009.423916249623;5033.370828646419;5038.420581633122;4797.2324428091515;4846.176150054499;4889.29105279736;4898.485659005824;4915.852524424273;4895.510448955111;4923.876903077416;4924.298981694386;4930.211166213388;4978.452370239271;4812.687175333592;4906.901861962777;4916.213405855082;4921.089598424267;4952.975235123838;5171.870703232412;5205;5228.320318358589;5248;5272.894542109137;5824.504917082053;5830.970845145789;5833.037548804442;5842.766289348463;5899.380565040695;5742.626729262626;5862.443067908542;5941.643501389887;5943.227380440559;5945.197398351211;5476.2333273341765;5535.723213839292;5536.916946245809;5540;5588.524975377098;5903.144044113579;5928.08114742207;5954.07711804671;5972.13404056418;5981.850453738692;5493.423190565013;5602.775888964477;5691.630044047207;5693.743781529841;5715.799947001835;5727.77088916447;5729.169270455844;5737.454941780524;5817.7091145442555;5852.648841069549;5672.404397538282;5740.196372507852;5744.540436765049;5752.395998420189;5764.827055188351;5686.545076393879;5731.799387021434;5793.044147715664;5798.9130163047585;5800.8259752207505;4504.054148628825;4514.751688657089;4518;4528.456585209796;4560.429946256718;4020.396940458896;4033.979830100831;4050.7913797728647;4063.9390409143884;4090.1001779608437;5266.868328291824;5378.704171270618;5394.73026348681;5495.368032676213;5551.195076713854;5801.854953626109;5804.303483581997;5811.128330750421;5824.184614154022;5830.47525722687;5438.673679579238;5443.455654434525;5446.509814116748;5450.073487507133;5450.427705090988;4932.186189278729;4992.051510213048;5052.444231134572;5071.949280507148;5112.667676601083;6019.217501724747;6046.486048685823;6046.879062418727;6048.274207095177;6048.879022419527;5745.741441635053;5832.066869300891;5842.795502157404;5847.795327163529;5857.707114644336;5959.553033522417;6012.6993650316435;6056.818295451144;6103.633781973096;6105.297890742444;5671.517920976763;5672.205891175321;5703.62926409782;5711.7429715662065;5715.114157305624;5728.140778883201;5764.567657425626;5764.625299355528;5766.567507437043;5823.883522329615;5554.194641776839;5655.095184770417;5783.334916484489;5793.478586927196;5823.4176582343125;5641.576881733969;5648.293963254593;5650.689212093374;5658.179563963285;5662.5469962402085;5495.945040549544;5513.531349835309;5513.8345849624575;5520.254765606753;5634.436556344497;5624.409437009055;5642.463965923231;5681.147827825859;5776.797812076557;5800.100984347433;5564.387917329172;5575.581831362745;5604.551635869202;5615.494605485526;5625.887482250414 19:05:54 INFO - PROCESS | 3576 | |1;ext.html;545.2666164009406;546.229815959497;563.1159080244017;574.6781802190774;597.1848426897286;34892.82553587232;35657.46513802295;35675.57297708088;35703.82148089256;35790.46314305284;37555;37882.621173788255;37883.24233515328;37893.24213515728;37942.62057379425;8277.420580559348;8494.320454363668;8502.702405415812;8533.74398768035;8548.78628034301;8313.33493320533;8406.075331713506;8415.242628163463;8642.30861531076;8669.349798765086;8551.230389264965;8701.695440659578;8706.47761134334;8738.126187381275;8788.51663158526;8616.956915215414;8668.00317963436;8698.304135669163;8720.43317184381;8730.912690873074;8442.915570844274;8586.398952073358;8632.266257368132;8651.65393384264;8653.26447251978;38184.42723359124;38270.42594361087;38543.42184867229;38634;38674.80662596697;3026.9848650756603;3269;3298.0765385692043;3551.4140166872435;3663.5970043295215;27959.720402795916;28994.710052899412;29197.562036569467;30021.399572008657;30381.848090759406;3097.3650401667605;3129.340429027302;3154.164146501179;3168.2396224905856;3262.1029216965285;254743;255993;256426;256710;257766;39945.80027099904;40954;40985.59014409877;54802;55167.17249241265;39282.60717392789;39335.40996885049;39489.802550987064;39500.20999579992;39541.80229098893;13729.519466818614;13861.306934653227;13885.58343249684;13902.652433689238;13910.58268251954;11774.882251177378;11839.644810655695;11850.407479626158;11863.050955923505;11864.703382415337;14065.578032659037;14105.294735263196;14162.150270983773;14188.503402380868;14236.928815356065;5785.50823180026;5926.081457374028;5941.969595506236;5952.196453478811;5985.730642121115;955.0115630322583;990.6087095597198;1006.8691070160833;1024.6464969585481;1139.8746137924823;28050.2987425316;28831.2792180193;28913.277168070967;28984.855075724907;29020.419591608472;998.2662742883974;1016.7864748402918;1021.0249212002519;1025.2618114957368;1138.9145814063813;14693.55919322422;14907.92546037263;14942.925285373503;15121.773173402407;15138.318775655121;304687;305264;305889;306272;306957;49974.750126249135;50877.74561127245;51088;51092;51113.48886511087;1352.0738294268458;1354.1739538881275;1356.1049707193206;1356.8236129303127;1359.136948038003;27341.179764607095;28300.575491368058;28501.42997140087;28753;28851.7114828849;39363;39670.60329396669;39769.20461590694;39878.80060599678;39938.40092398558;285148;287182;287418;287663;287861;32428.83785581057;44823.55176448324;45028;45167.548324516334;45970.540294597966;41499.7925010373;41668;41922.79038604788;41990.37014444847;42306.36540451957;35044.29911401809;35080;35360.64639353574;35490.8225458871;35570.64429355673;35208.295834083685;35210;35420;35435.468467973515;35471.82264088663;34259.65740342565;34967;35130.12174695653;35217.64782352144;35330;31979;32179.35641287208;32822.835885820416;33091.33817323688;33181;25026.62460063064;25184.37039074038;25398.619020715072;25422.364440889127;25544.744552554235 19:05:54 INFO - PROCESS | 3576 | |2;jquery.html;354.9130463036556;356.4510653593466;359.8776416018553;360.18597968590996;360.77091047185036;11506.30962142272;11923.284602923808;16393.75409368859;16737.665246695073;17335.21991510382;17281.222344994472;17495.73756393652;17611.11944402778;17624.471265862045;17713.82286177138;5905.822825315247;6044.7279872405625;6072.605280656765;6077.483413909823;6084;5381.92361527696;5989.431004054608;6019.638821670714;6047.274327080757;6067.666278354689;6007.819765407023;6023.789167379143;6065.514758819306;6068.998615228504;6084.634921904678;5788.536917046647;5997.820065398001;6020.729067191987;6057.212562366886;6068.271807383098;5791.797287094932;5801.129830525413;5803;5803.82588522345;5804.100364443476;22125.336239912827;22303.438759286855;22670.319890403316;23389.41526461835;23750.287491375286;1950.3758797184908;2004.5589970206531;2113.17586141405;2306.850054746436;2321.2688003278913;13979.23114228717;14287.499937502242;14328;14718.33767480466;14785.704285914222;1811.1035037656313;1816.6003479234548;1949.2787668562723;2066.865653732518;2190.7480639726477;52266.47733522654;52925.20612190859;56060.43939560593;62686.37313626851;70599.94100088502;14944;15559.29983150761;15630.296636651377;15703.136327502098;15706.607334816721;12993.415296311689;13413.0610857241;13438.260895650637;24306;24455.266342009767;7693.807654808563;7820.413468989848;7893.644785984645;7902.525848448997;7930.167332430127;7784.8053798654355;7822.687092516349;7829.843403132019;7831.6475758591005;7866.842663146705;4335.609795118455;4376.256036473807;4426.203283408953;4429.490608580055;4498.370228168059;1862.310944950377;1895.9810401895804;1901.8288354047925;1903.3528600275972;1915.4636701723539;860.978475538104;895.3240303570763;917.5779141594808;942.6276620734772;1012.7215015870695;16762.664746705;17018.234179461953;17021.40425085116;17058.938046912757;17096.14519274056;924.7734305095295;929.5677509957767;945.3429866243033;998.1665309466531;1018.221060888421;9759.9024009759;9913.752156196153;9923.809142902754;9965.252606054575;9966.501674916226;564120;576696;583592;589504;594094;76430.61784691153;77560;79941.60029199817;80899.5955020233;81230;1103.9834402483968;1110.3337997201616;1158.0966845860241;1166.1836714300025;1170.6371024982284;15061.924690376478;15147.242637867843;15279.61800954985;15299.235038248265;15780.842191578397;30517.694823051486;31777.20556986094;32751.18122046968;33978.490322644684;35285.1178720534;41045.794771025954;42289.365659515744;42703;43684.78157609192;45769;9079.863802042843;9236.815263694823;9326.860097098413;9374.95312523433;9385.202257808163;11247.66257012291;11349;12146.939265303618;16370.67258654844;16622.168891555615;13590.45638174462;13693.589192324247;13772.24252666113;13899.930500347433;13932.164070155823;13256.337183140611;13785.310734463035;13862.584122476343;13951.581452556033;14068.507602233873;13940.651483712989;14123.858761412253;14230;14556.85443145555;14596.635084122981;9612.327137100336;9659.323847330901;9758.560864761244;9763.414195148314;9867.950660246654;12527.812082818948;14233.217173055167;14310.856891430953;14372.28138593087;14686.55940321792 19:05:54 INFO - PROCESS | 3576 | |3;mootools.html;1495.940162393504;1502.564256365654;1689.5944973206433;1819.2995696656783;1849.398945342764;7088.503804733671;7234.891476627855;7846.607669616525;8020.11778704342;8037.075736290321;7567.3567746741455;7619.42854285928;7687.423443241752;7713.5757533335645;7724.459287849839;2301.1140710826285;2307.492351682627;2330.2426711318803;2333.9533209335805;2334.393057804966;2304.1474654377903;2319.3158018384534;2341.7072865891764;2343.0627748900406;2365.8107351411845;2219.511707424372;2228.2869481765842;2240.8543444676043;2341.0518739910362;2346.9882650586724;2305.7694230576976;2321.767823217673;2359.457324815302;2361.3860396296914;2363.4327761337327;2155.8706477611236;2171.3160354488446;2179.4442417183677;2179.945501362463;2192.967105493419;7938.483998540134;7994.160613135653;8005.799855003614;8035.316998055172;8047.074586422578;4718.693284936468;4769;4788.928166077477;4791.592714619262;4793.520647935214;2936.750376218024;2966.495695731731;2996.7752418568693;3007.443622929765;3039.9088027359217;894.1550235027901;906.9909300907038;918.4305730447165;942.1238248428958;948.1892981500855;10994.560217591286;11016.559337626486;11029.779404411867;11083.390413527253;11100.888991110067;4407.2507673695545;4425.955740442619;4437.33439984005;4479.753613551221;4481.5070342262325;9452.952735236417;9456.054394560626;9460.810783784424;9470.905290947003;9484;4953.479884612136;4955.4548999610015;4967.081089998362;4967.180415231446;4969.975150124226;4343.979164896246;4437.622802061861;4453.621442177387;4460.598546130864;4517.11916176349;3621.1128273572617;3623.9818800906355;3634.545681789776;3645.1251699592435;3652.3608368535934;1109.5506319940437;1117.4915413487006;1147.6614398752388;1157.1205883528578;1174.7650469905882;1201.5374080978886;1216.0271782573905;1235.0305010566663;1282.5831604728314;1289.5615490733196;7506.399488040944;7595.924040759522;7600.771976840593;7641.656125474367;7649.502782319131;485.2624011502496;491.64355842014254;515.5308669111091;517.751479289943;522.848373971544;5851.765929362863;5877.177195192677;5892.6759028253;5900.793472228452;5903.586748927534;9070.455772653662;9506.619735210652;9582.760430989281;9603.423794572349;9654.27592930533;9448.858267126;9453.669121580711;9476.289278304155;9480.762980925532;9560.665376711782;7315.707371705073;7563.9621801891735;7583.582902940391;7637.961810191025;7655.1962043985695;7014.789556313319;7120.038794762848;7160.856782864418;7164.713411463483;7187.676554554953;8443.83112337762;8501.489910605384;8507.97904251469;8590.871136932827;8691.695790647549;8574;8713.433626814236;8731.91268087311;8814.33892458081;8836.867446988172;6713.328667133248;6736.157980252468;6802.795916122524;6867.244603093556;6873.518853680194;7530.661120249492;7539.32146106853;7540.434467415075;7612.238776122344;7633;6952.617606031717;7115;7119.394851437479;7270.018547496232;7281.635918204174;6908.758193463204;6970.337817907291;6991.405730512964;7120.750773722895;7173.856522869409;6773.62745049027;7001.054857594159;7300.561966281828;7329.1937886833475;7334.559926404219;6475.676216189266;6585.242697089896;6590.868182636224;6600.273969863215;6643;6468.450181734605;6496.512761542808;6538.280789113289;6691.297413771678;6707.3628005339415 19:05:54 INFO - PROCESS | 3576 | |4;prototype.html;319.2911735946199;328.54004393848606;331.2596347164088;333.66800033966206;340.93522230776153;6153.384661533844;6238.40735130163;6264.185655864737;6284.371562843713;6293.276273228575;6052.60658057226;6169.938300616993;6190.473809726167;6222.0355844844125;6226.252849658036;4713.8451079485485;4715.056988602293;4723.17344464719;4727.810887564493;4728.763561821896;4705;4723.551262630044;4724.881877953045;4733.313669517918;4734.242521196609;4622.768861556909;4672.766361681919;4713.245880659095;4724.126036683225;4724.31497432872;4684.46128695201;4692.460367057781;4698.130845793522;4708.411448568929;4712.104700107003;3970.5235371755284;4061.8375264989363;4111.938320925188;4120.773357465338;4121.793910304503;5842.795502157404;5859.326177489601;5882.705864706748;5882.882342353172;5935.1987481690285;5429.755660995264;5430.728463576845;5442.428545002757;5474.343078830526;5475.5072043515875;6579.9671001645165;6595.406413422815;6598.868022639568;6616.900746488806;6634.237062737799;4334.848280310205;4419.690621656486;4422.093470838503;4429.313456414228;4441.666874984389;6811.421029212523;6952.756653517103;6954.930450695479;6958.130233720785;6961.860762784716;4613.469451013109;4621.3068039793625;4622.352870598119;4630.560096790799;4630.745309008037;4583.816647334069;4609.3086037094035;4661.300804879227;4668.906621867543;4680.368150299734;5424.321959755031;5424.674519528841;5428.891422171534;5429.104197807396;5445.346558413015;6649.700763465656;6650.833729156713;6660.833479162963;6668.6665666717445;6683.298253683391;1642.0476123848139;1666.9749953750704;1668.7246604310396;1668.7747154134279;1673.782408286915;1073.6188653028219;1077.7144056824948;1089.145021158387;1098.3958822647512;1115.7880002799604;6350.968245158745;6358.523110766711;6358.841028974312;6365.777197798147;6366.7771627993725;6909.447244220451;6910.101686780787;6914.545336405504;6917.757878474229;6925.411340036153;6265.592736472115;6340.492760579143;6344.904826427607;6355.428011478989;6355.682215889187;3766.4162054881535;3789.905252368658;3794.6964242860504;3795.886123416302;3798.8860334189467;7070.611116388545;7279.45404094695;7283.745068922668;7286.70853165878;7289.052423184952;7127.144742630918;7146.606936618432;7149.0348802911985;7150.749723759747;7152.749653762094;7063.117110361205;7253.492255542167;7255.637218139072;7261.709531618676;7285.562866228043;6947.861042779217;6958.7216511341;6960.164780226405;6967.965160174167;6978.057962175244;6878.621675807678;6893.862122757617;6895.4138898194215;6914.0666010088;6926.792196234121;7089.511202647295;7231.746888858865;7236.819079523054;7260.201377848327;7262.891056634049;4524.253498172765;4579.129965306581;4587.1972404829685;4588.0730093361535;4588.944542755118;6956.513044086865;6984.441244700513;6993.370596646327;6993.580385176906;7014.158301003912;6671;6682.19813622349;6746.123004009447;6762.222344430454;6770.45836333102;6754.763583274562;6755.121834161528;6769.086173366532;6786.151731033621;6797.048413222252;6611.768588099393;6618.702158402787;6645.534812563074;6656;6660.300668429939;6627.602343859384;6801.387875091265;6813.2846051163915;6817.761378351734;6822.317768223138;6564.310747371457;6576.901346479903;6625.9067253904495;6631.436327911989;6650.46796256308 19:05:54 INFO - PROCESS | 3576 | |5;yui.html;689.3210187964855;689.6586189836029;712.9607871567061;785.6739453126953;806.193806193806;13246.801297980526;13500;13579.864201357996;13641.249731264776;13645.181289122647;12418.254904705702;12531.749365012716;12532.373381330919;12542.623721288353;12577.056720745935;673.3636713305928;677.8915373540234;782.9412794040455;820.1634332980357;824.4558591329724;813.3208770676463;818.6316157729016;830.1905641999062;831.4637059096879;831.5675848558745;870.0646804684957;871.7689812199773;878.2798105553449;880.5113162194979;883.0463099852144;862.9741107766714;863.935204859635;864.909184535621;867.0549101479386;876.9254613357872;636.6339354870921;644.4039263681076;646.0954663471178;648.3937518420292;649.8602800397937;13493.932530337384;13501.189928604315;13537.255450950193;13538.458461661521;13554.186748795104;11874.940625296818;12456.688582785413;12574.371281435982;12890.291033993126;12962.157459765085;10311.1235544978;10542.578296868116;10669.733256668567;10874.728131796768;10944.616938407196;3648.7081033517256;3665.083729067733;3673.3204357194004;3677.9080522986874;3788.1287303919976;44786.77606611979;46066.76966615179;46521.53478465206;46531.76734116342;46573;9641.614335426644;9828.852567211497;9867.30928834989;9896.10935015852;10064;17567.20947557363;17595.38416155454;17641.911790441223;17666.5583360417;17723.73414398785;7033.753818616324;7185.748498802622;7401.370883474858;7407.296306850841;7664.271894170045;3952.3281042222893;3965.0682089708894;3969.64273215412;4033.6974726895014;4062.6749860011128;3042.8934987275784;3053.694630536973;3070.6161729783776;3094.8143111413387;3103.2707313781243;547.2229434203441;591.7011908985935;600.1597763131564;616.0389791924612;619.6437048697018;570.5407147246507;623.7380300273896;625.4933503861887;664.1266734244454;675.3584095109567;8090.838183236302;8176.509409435453;8211.466254693425;8248.298894593907;8340.332773378115;521.7625980179009;564.2213745031912;593.3680630128899;634.9459896571669;683.6786710246176;4074.6332830044844;4222.472190976128;4278.914421711548;4327.7186982846015;4526.95473045272;50623.49376506188;51000.74499627478;51290.48709512932;51470.485295147315;54814.45185548093;44653.33020004703;45485.772571136935;45785.542144578794;45908.08183836305;45961.31058034132;41791.58208417877;41921.79039104846;42116.94707632395;42405.151896961885;42593.57406425958;8169.79575510617;8399.622017009127;8427.747167584983;8758.47449153053;8779.297656187617;30295.394092118477;30699;31307.84346078255;31462.685373145974;31510.68489315169;40253.39619905645;41033.794831025654;41035.7948210257;41054;41160.58839411568;10989.890101098887;11313.321200727984;11366.033887119687;11576.536938522702;11644.417779110841;11716.115981119325;12092.576759813364;12344.567940122412;12388.256704597752;12400;10398.220133489867;10440;10513.421761803174;10549.208809339178;10728;11013.669589912315;11059.22585419013;11131.499082541468;12008.279503229835;12453.315067671365;10778.73053173677;11002.724931876766;11118.944405277922;11120.777584448428;11328.886711132784;10081.096335316974;10137.543810528396;10204.693859184237;10250.179985600986;10420.166386689198;8490.787730306793;8703.303735701254;8767.693130740394;9213.493257870881;9222.815543688954 19:05:54 INFO - PROCESS | 3576 | __end_tp_report 19:05:54 INFO - PROCESS | 3576 | __start_cc_report 19:05:54 INFO - PROCESS | 3576 | _x_x_mozilla_cycle_collect,306 19:05:54 INFO - PROCESS | 3576 | __end_cc_report 19:05:54 INFO - PROCESS | 3576 | __startTimestamp1451444754655__endTimestamp 19:05:54 INFO - PROCESS | 3576 | 19:05:54 INFO - PROCESS | 3576 | ------- Summary: start ------- 19:05:54 INFO - PROCESS | 3576 | Number of tests: 6 19:05:54 INFO - PROCESS | 3576 | 19:05:54 INFO - PROCESS | 3576 | [#0] dojo.html Cycles:165 Average:5386.04 Median:5588.52 stddev:591.56 (10.6%) stddev-sans-first:567.82 19:05:54 INFO - PROCESS | 3576 | Values: 3193.5 3245.6 3277.6 3297.3 3299.2 5186.4 5252.2 5257.1 5338.1 5345.2 5293.3 5311.6 5359.5 5410.3 5413.8 4827.0 4853.9 4921.9 4926.6 4981.7 4967.4 5001.1 5009.4 5033.4 5038.4 4797.2 4846.2 4889.3 4898.5 4915.9 4895.5 4923.9 4924.3 4930.2 4978.5 4812.7 4906.9 4916.2 4921.1 4953.0 5171.9 5205.0 5228.3 5248.0 5272.9 5824.5 5831.0 5833.0 5842.8 5899.4 5742.6 5862.4 5941.6 5943.2 5945.2 5476.2 5535.7 5536.9 5540.0 5588.5 5903.1 5928.1 5954.1 5972.1 5981.9 5493.4 5602.8 5691.6 5693.7 5715.8 5727.8 5729.2 5737.5 5817.7 5852.6 5672.4 5740.2 5744.5 5752.4 5764.8 5686.5 5731.8 5793.0 5798.9 5800.8 4504.1 4514.8 4518.0 4528.5 4560.4 4020.4 4034.0 4050.8 4063.9 4090.1 5266.9 5378.7 5394.7 5495.4 5551.2 5801.9 5804.3 5811.1 5824.2 5830.5 5438.7 5443.5 5446.5 5450.1 5450.4 4932.2 4992.1 5052.4 5071.9 5112.7 6019.2 6046.5 6046.9 6048.3 6048.9 5745.7 5832.1 5842.8 5847.8 5857.7 5959.6 6012.7 6056.8 6103.6 6105.3 5671.5 5672.2 5703.6 5711.7 5715.1 5728.1 5764.6 5764.6 5766.6 5823.9 5554.2 5655.1 5783.3 5793.5 5823.4 5641.6 5648.3 5650.7 5658.2 5662.5 5495.9 5513.5 5513.8 5520.3 5634.4 5624.4 5642.5 5681.1 5776.8 5800.1 5564.4 5575.6 5604.6 5615.5 5625.9 19:05:54 INFO - PROCESS | 3576 | 19:05:54 INFO - PROCESS | 3576 | [#1] ext.html Cycles:180 Average:44059.66 Median:35345.32 stddev:74094.25 (209.6%) stddev-sans-first:74230.07 19:05:54 INFO - PROCESS | 3576 | Values: 545.3 546.2 563.1 574.7 597.2 34892.8 35657.5 35675.6 35703.8 35790.5 37555.0 37882.6 37883.2 37893.2 37942.6 8277.4 8494.3 8502.7 8533.7 8548.8 8313.3 8406.1 8415.2 8642.3 8669.3 8551.2 8701.7 8706.5 8738.1 8788.5 8617.0 8668.0 8698.3 8720.4 8730.9 8442.9 8586.4 8632.3 8651.7 8653.3 38184.4 38270.4 38543.4 38634.0 38674.8 3027.0 3269.0 3298.1 3551.4 3663.6 27959.7 28994.7 29197.6 30021.4 30381.8 3097.4 3129.3 3154.2 3168.2 3262.1 254743.0 255993.0 256426.0 256710.0 257766.0 39945.8 40954.0 40985.6 54802.0 55167.2 39282.6 39335.4 39489.8 39500.2 39541.8 13729.5 13861.3 13885.6 13902.7 13910.6 11774.9 11839.6 11850.4 11863.1 11864.7 14065.6 14105.3 14162.2 14188.5 14236.9 5785.5 5926.1 5942.0 5952.2 5985.7 955.0 990.6 1006.9 1024.6 1139.9 28050.3 28831.3 28913.3 28984.9 29020.4 998.3 1016.8 1021.0 1025.3 1138.9 14693.6 14907.9 14942.9 15121.8 15138.3 304687.0 305264.0 305889.0 306272.0 306957.0 49974.8 50877.7 51088.0 51092.0 51113.5 1352.1 1354.2 1356.1 1356.8 1359.1 27341.2 28300.6 28501.4 28753.0 28851.7 39363.0 39670.6 39769.2 39878.8 39938.4 285148.0 287182.0 287418.0 287663.0 287861.0 32428.8 44823.6 45028.0 45167.5 45970.5 41499.8 41668.0 41922.8 41990.4 42306.4 35044.3 35080.0 35360.6 35490.8 35570.6 35208.3 35210.0 35420.0 35435.5 35471.8 34259.7 34967.0 35130.1 35217.6 35330.0 31979.0 32179.4 32822.8 33091.3 33181.0 25026.6 25184.4 25398.6 25422.4 25544.7 19:05:54 INFO - PROCESS | 3576 | 19:05:54 INFO - PROCESS | 3576 | [#2] jquery.html Cycles:180 Average:30233.57 Median:34631.80 stddev:94862.19 (273.9%) stddev-sans-first:95101.77 19:05:54 INFO - PROCESS | 3576 | Values: 354.9 356.5 359.9 360.2 360.8 11506.3 11923.3 16393.8 16737.7 17335.2 17281.2 17495.7 17611.1 17624.5 17713.8 5905.8 6044.7 6072.6 6077.5 6084.0 5381.9 5989.4 6019.6 6047.3 6067.7 6007.8 6023.8 6065.5 6069.0 6084.6 5788.5 5997.8 6020.7 6057.2 6068.3 5791.8 5801.1 5803.0 5803.8 5804.1 22125.3 22303.4 22670.3 23389.4 23750.3 1950.4 2004.6 2113.2 2306.9 2321.3 13979.2 14287.5 14328.0 14718.3 14785.7 1811.1 1816.6 1949.3 2066.9 2190.7 52266.5 52925.2 56060.4 62686.4 70599.9 14944.0 15559.3 15630.3 15703.1 15706.6 12993.4 13413.1 13438.3 24306.0 24455.3 7693.8 7820.4 7893.6 7902.5 7930.2 7784.8 7822.7 7829.8 7831.6 7866.8 4335.6 4376.3 4426.2 4429.5 4498.4 1862.3 1896.0 1901.8 1903.4 1915.5 861.0 895.3 917.6 942.6 1012.7 16762.7 17018.2 17021.4 17058.9 17096.1 924.8 929.6 945.3 998.2 1018.2 9759.9 9913.8 9923.8 9965.3 9966.5 564120.0 576696.0 583592.0 589504.0 594094.0 76430.6 77560.0 79941.6 80899.6 81230.0 1104.0 1110.3 1158.1 1166.2 1170.6 15061.9 15147.2 15279.6 15299.2 15780.8 30517.7 31777.2 32751.2 33978.5 35285.1 41045.8 42289.4 42703.0 43684.8 45769.0 9079.9 9236.8 9326.9 9375.0 9385.2 11247.7 11349.0 12146.9 16370.7 16622.2 13590.5 13693.6 13772.2 13899.9 13932.2 13256.3 13785.3 13862.6 13951.6 14068.5 13940.7 14123.9 14230.0 14556.9 14596.6 9612.3 9659.3 9758.6 9763.4 9868.0 12527.8 14233.2 14310.9 14372.3 14686.6 19:05:54 INFO - PROCESS | 3576 | 19:05:54 INFO - PROCESS | 3576 | [#3] mootools.html Cycles:180 Average:5535.51 Median:6595.57 stddev:2911.01 (44.1%) stddev-sans-first:2903.34 19:05:54 INFO - PROCESS | 3576 | Values: 1495.9 1502.6 1689.6 1819.3 1849.4 7088.5 7234.9 7846.6 8020.1 8037.1 7567.4 7619.4 7687.4 7713.6 7724.5 2301.1 2307.5 2330.2 2334.0 2334.4 2304.1 2319.3 2341.7 2343.1 2365.8 2219.5 2228.3 2240.9 2341.1 2347.0 2305.8 2321.8 2359.5 2361.4 2363.4 2155.9 2171.3 2179.4 2179.9 2193.0 7938.5 7994.2 8005.8 8035.3 8047.1 4718.7 4769.0 4788.9 4791.6 4793.5 2936.8 2966.5 2996.8 3007.4 3039.9 894.2 907.0 918.4 942.1 948.2 10994.6 11016.6 11029.8 11083.4 11100.9 4407.3 4426.0 4437.3 4479.8 4481.5 9453.0 9456.1 9460.8 9470.9 9484.0 4953.5 4955.5 4967.1 4967.2 4970.0 4344.0 4437.6 4453.6 4460.6 4517.1 3621.1 3624.0 3634.5 3645.1 3652.4 1109.6 1117.5 1147.7 1157.1 1174.8 1201.5 1216.0 1235.0 1282.6 1289.6 7506.4 7595.9 7600.8 7641.7 7649.5 485.3 491.6 515.5 517.8 522.8 5851.8 5877.2 5892.7 5900.8 5903.6 9070.5 9506.6 9582.8 9603.4 9654.3 9448.9 9453.7 9476.3 9480.8 9560.7 7315.7 7564.0 7583.6 7638.0 7655.2 7014.8 7120.0 7160.9 7164.7 7187.7 8443.8 8501.5 8508.0 8590.9 8691.7 8574.0 8713.4 8731.9 8814.3 8836.9 6713.3 6736.2 6802.8 6867.2 6873.5 7530.7 7539.3 7540.4 7612.2 7633.0 6952.6 7115.0 7119.4 7270.0 7281.6 6908.8 6970.3 6991.4 7120.8 7173.9 6773.6 7001.1 7300.6 7329.2 7334.6 6475.7 6585.2 6590.9 6600.3 6643.0 6468.5 6496.5 6538.3 6691.3 6707.4 19:05:54 INFO - PROCESS | 3576 | 19:05:54 INFO - PROCESS | 3576 | [#4] prototype.html Cycles:180 Average:5561.78 Median:6316.88 stddev:1722.86 (27.3%) stddev-sans-first:1682.16 19:05:54 INFO - PROCESS | 3576 | Values: 319.3 328.5 331.3 333.7 340.9 6153.4 6238.4 6264.2 6284.4 6293.3 6052.6 6169.9 6190.5 6222.0 6226.3 4713.8 4715.1 4723.2 4727.8 4728.8 4705.0 4723.6 4724.9 4733.3 4734.2 4622.8 4672.8 4713.2 4724.1 4724.3 4684.5 4692.5 4698.1 4708.4 4712.1 3970.5 4061.8 4111.9 4120.8 4121.8 5842.8 5859.3 5882.7 5882.9 5935.2 5429.8 5430.7 5442.4 5474.3 5475.5 6580.0 6595.4 6598.9 6616.9 6634.2 4334.8 4419.7 4422.1 4429.3 4441.7 6811.4 6952.8 6954.9 6958.1 6961.9 4613.5 4621.3 4622.4 4630.6 4630.7 4583.8 4609.3 4661.3 4668.9 4680.4 5424.3 5424.7 5428.9 5429.1 5445.3 6649.7 6650.8 6660.8 6668.7 6683.3 1642.0 1667.0 1668.7 1668.8 1673.8 1073.6 1077.7 1089.1 1098.4 1115.8 6351.0 6358.5 6358.8 6365.8 6366.8 6909.4 6910.1 6914.5 6917.8 6925.4 6265.6 6340.5 6344.9 6355.4 6355.7 3766.4 3789.9 3794.7 3795.9 3798.9 7070.6 7279.5 7283.7 7286.7 7289.1 7127.1 7146.6 7149.0 7150.7 7152.7 7063.1 7253.5 7255.6 7261.7 7285.6 6947.9 6958.7 6960.2 6968.0 6978.1 6878.6 6893.9 6895.4 6914.1 6926.8 7089.5 7231.7 7236.8 7260.2 7262.9 4524.3 4579.1 4587.2 4588.1 4588.9 6956.5 6984.4 6993.4 6993.6 7014.2 6671.0 6682.2 6746.1 6762.2 6770.5 6754.8 6755.1 6769.1 6786.2 6797.0 6611.8 6618.7 6645.5 6656.0 6660.3 6627.6 6801.4 6813.3 6817.8 6822.3 6564.3 6576.9 6625.9 6631.4 6650.5 19:05:54 INFO - PROCESS | 3576 | 19:05:54 INFO - PROCESS | 3576 | [#5] yui.html Cycles:180 Average:13037.28 Median:23313.81 stddev:14449.80 (62.0%) stddev-sans-first:14460.58 19:05:54 INFO - PROCESS | 3576 | Values: 689.3 689.7 713.0 785.7 806.2 13246.8 13500.0 13579.9 13641.2 13645.2 12418.3 12531.7 12532.4 12542.6 12577.1 673.4 677.9 782.9 820.2 824.5 813.3 818.6 830.2 831.5 831.6 870.1 871.8 878.3 880.5 883.0 863.0 863.9 864.9 867.1 876.9 636.6 644.4 646.1 648.4 649.9 13493.9 13501.2 13537.3 13538.5 13554.2 11874.9 12456.7 12574.4 12890.3 12962.2 10311.1 10542.6 10669.7 10874.7 10944.6 3648.7 3665.1 3673.3 3677.9 3788.1 44786.8 46066.8 46521.5 46531.8 46573.0 9641.6 9828.9 9867.3 9896.1 10064.0 17567.2 17595.4 17641.9 17666.6 17723.7 7033.8 7185.7 7401.4 7407.3 7664.3 3952.3 3965.1 3969.6 4033.7 4062.7 3042.9 3053.7 3070.6 3094.8 3103.3 547.2 591.7 600.2 616.0 619.6 570.5 623.7 625.5 664.1 675.4 8090.8 8176.5 8211.5 8248.3 8340.3 521.8 564.2 593.4 634.9 683.7 4074.6 4222.5 4278.9 4327.7 4527.0 50623.5 51000.7 51290.5 51470.5 54814.5 44653.3 45485.8 45785.5 45908.1 45961.3 41791.6 41921.8 42116.9 42405.2 42593.6 8169.8 8399.6 8427.7 8758.5 8779.3 30295.4 30699.0 31307.8 31462.7 31510.7 40253.4 41033.8 41035.8 41054.0 41160.6 10989.9 11313.3 11366.0 11576.5 11644.4 11716.1 12092.6 12344.6 12388.3 12400.0 10398.2 10440.0 10513.4 10549.2 10728.0 11013.7 11059.2 11131.5 12008.3 12453.3 10778.7 11002.7 11118.9 11120.8 11328.9 10081.1 10137.5 10204.7 10250.2 10420.2 8490.8 8703.3 8767.7 9213.5 9222.8 19:05:54 INFO - PROCESS | 3576 | -------- Summary: end -------- 19:05:54 INFO - PROCESS | 3576 | 19:05:55 INFO - TEST-INFO | 3576: exit 0 19:05:55 INFO - TEST-OK | dromaeo_css | took 1111085ms 19:05:55 INFO - TEST-START | kraken 19:05:55 INFO - operating with platform_type : linux_ 19:05:55 INFO - Initialising browser for kraken test... 19:05:55 INFO - TEST-INFO | started process 3813 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpuigdL4/profile http://localhost:35334/getInfo.html) 19:05:56 INFO - PROCESS | 3813 | Failed to load Oculus VR library! 19:05:59 INFO - PROCESS | 3813 | Failed to load Oculus VR library! 19:06:00 INFO - PROCESS | 3813 | __metrics Screen width/height:1600/1200 19:06:00 INFO - PROCESS | 3813 | colorDepth:24 19:06:00 INFO - PROCESS | 3813 | Browser inner width/height: 1024/697 19:06:00 INFO - PROCESS | 3813 | __metrics 19:06:00 INFO - PROCESS | 3813 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:06:01 INFO - TEST-INFO | 3813: exit 0 19:06:01 INFO - Browser initialized. 19:06:01 INFO - Running cycle 1/1 for kraken test... 19:06:01 INFO - TEST-INFO | started process 3938 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpuigdL4/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:06:01 INFO - PROCESS | 3938 | Failed to load Oculus VR library! 19:06:02 INFO - PROCESS | 3938 | Failed to load Oculus VR library! 19:06:12 INFO - PROCESS | 3938 | RSS: Main: 149753856 19:06:12 INFO - PROCESS | 3938 | 19:06:15 INFO - PROCESS | 3938 | Cycle 1(1): loaded http://localhost:35334/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35334/tests/kraken/driver.html?testName=audio-beat-detection) 19:06:15 INFO - PROCESS | 3938 | RSS: Main: 152129536 19:06:15 INFO - PROCESS | 3938 | 19:06:18 INFO - PROCESS | 3938 | Cycle 1(1): loaded http://localhost:35334/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35334/tests/kraken/driver.html?testName=audio-dft) 19:06:19 INFO - PROCESS | 3938 | RSS: Main: 150265856 19:06:19 INFO - PROCESS | 3938 | 19:06:22 INFO - PROCESS | 3938 | Cycle 1(1): loaded http://localhost:35334/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35334/tests/kraken/driver.html?testName=audio-fft) 19:06:22 INFO - PROCESS | 3938 | RSS: Main: 146784256 19:06:22 INFO - PROCESS | 3938 | 19:06:24 INFO - PROCESS | 3938 | Cycle 1(1): loaded http://localhost:35334/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35334/tests/kraken/driver.html?testName=audio-oscillator) 19:06:25 INFO - PROCESS | 3938 | RSS: Main: 146305024 19:06:25 INFO - PROCESS | 3938 | 19:06:27 INFO - PROCESS | 3938 | Cycle 1(1): loaded http://localhost:35334/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35334/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:06:28 INFO - PROCESS | 3938 | RSS: Main: 147742720 19:06:28 INFO - PROCESS | 3938 | 19:06:31 INFO - PROCESS | 3938 | Cycle 1(1): loaded http://localhost:35334/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35334/tests/kraken/driver.html?testName=imaging-darkroom) 19:06:31 INFO - PROCESS | 3938 | RSS: Main: 148119552 19:06:31 INFO - PROCESS | 3938 | 19:06:35 INFO - PROCESS | 3938 | Cycle 1(1): loaded http://localhost:35334/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35334/tests/kraken/driver.html?testName=imaging-desaturate) 19:06:35 INFO - PROCESS | 3938 | RSS: Main: 148787200 19:06:35 INFO - PROCESS | 3938 | 19:06:38 INFO - PROCESS | 3938 | Cycle 1(1): loaded http://localhost:35334/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35334/tests/kraken/driver.html?testName=json-parse-financial) 19:06:39 INFO - PROCESS | 3938 | RSS: Main: 148463616 19:06:39 INFO - PROCESS | 3938 | 19:06:40 INFO - PROCESS | 3938 | Cycle 1(1): loaded http://localhost:35334/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35334/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:06:41 INFO - PROCESS | 3938 | RSS: Main: 149110784 19:06:41 INFO - PROCESS | 3938 | 19:06:43 INFO - PROCESS | 3938 | Cycle 1(1): loaded http://localhost:35334/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35334/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:06:43 INFO - PROCESS | 3938 | RSS: Main: 148631552 19:06:43 INFO - PROCESS | 3938 | 19:06:45 INFO - PROCESS | 3938 | Cycle 1(1): loaded http://localhost:35334/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35334/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:06:46 INFO - PROCESS | 3938 | RSS: Main: 149614592 19:06:46 INFO - PROCESS | 3938 | 19:06:48 INFO - PROCESS | 3938 | Cycle 1(1): loaded http://localhost:35334/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35334/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:06:49 INFO - PROCESS | 3938 | RSS: Main: 149004288 19:06:49 INFO - PROCESS | 3938 | 19:06:52 INFO - PROCESS | 3938 | Cycle 1(1): loaded http://localhost:35334/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35334/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:06:52 INFO - PROCESS | 3938 | RSS: Main: 148545536 19:06:52 INFO - PROCESS | 3938 | 19:06:54 INFO - PROCESS | 3938 | Cycle 1(1): loaded http://localhost:35334/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35334/tests/kraken/driver.html?testName=ai-astar) 19:06:54 INFO - PROCESS | 3938 | RSS: Main: 148320256 19:06:54 INFO - PROCESS | 3938 | 19:06:54 INFO - PROCESS | 3938 | __start_tp_report 19:06:54 INFO - PROCESS | 3938 | _x_x_mozilla_page_load 19:06:54 INFO - PROCESS | 3938 | _x_x_mozilla_page_load_details 19:06:54 INFO - PROCESS | 3938 | |i|pagename|runs| 19:06:54 INFO - PROCESS | 3938 | |0;ai-astar;111;108;111;111;111;122;113;113;113;112 19:06:54 INFO - PROCESS | 3938 | |1;audio-beat-detection;165;134;156;169;136;157;158;127;165;127 19:06:54 INFO - PROCESS | 3938 | |2;audio-dft;163;163;161;166;163;161;160;165;178;162 19:06:54 INFO - PROCESS | 3938 | |3;audio-fft;75;71;73;74;72;142;74;72;74;72 19:06:54 INFO - PROCESS | 3938 | |4;audio-oscillator;97;97;142;96;96;97;137;97;97;141 19:06:54 INFO - PROCESS | 3938 | |5;imaging-gaussian-blur;109;110;110;110;109;110;110;110;109;111 19:06:54 INFO - PROCESS | 3938 | |6;imaging-darkroom;150;149;147;146;146;147;146;147;147;147 19:06:54 INFO - PROCESS | 3938 | |7;imaging-desaturate;97;97;95;96;98;96;96;96;96;96 19:06:54 INFO - PROCESS | 3938 | |8;json-parse-financial;61;60;61;62;59;70;62;59;58;57 19:06:54 INFO - PROCESS | 3938 | |9;json-stringify-tinderbox;67;68;67;68;68;69;69;69;68;67 19:06:54 INFO - PROCESS | 3938 | |10;stanford-crypto-aes;88;88;89;88;95;86;89;88;87;88 19:06:54 INFO - PROCESS | 3938 | |11;stanford-crypto-ccm;122;126;134;126;121;125;118;117;137;132 19:06:54 INFO - PROCESS | 3938 | |12;stanford-crypto-pbkdf2;144;153;160;154;156;145;155;153;157;160 19:06:54 INFO - PROCESS | 3938 | |13;stanford-crypto-sha256-iterative;72;71;67;73;71;68;69;68;69;71 19:06:54 INFO - PROCESS | 3938 | __end_tp_report 19:06:54 INFO - PROCESS | 3938 | __start_cc_report 19:06:54 INFO - PROCESS | 3938 | _x_x_mozilla_cycle_collect,722 19:06:54 INFO - PROCESS | 3938 | __end_cc_report 19:06:54 INFO - PROCESS | 3938 | __startTimestamp1451444814777__endTimestamp 19:06:54 INFO - PROCESS | 3938 | 19:06:54 INFO - PROCESS | 3938 | ------- Summary: start ------- 19:06:54 INFO - PROCESS | 3938 | Number of tests: 14 19:06:54 INFO - PROCESS | 3938 | 19:06:54 INFO - PROCESS | 3938 | [#0] ai-astar Cycles:10 Average:112.50 Median:112.50 stddev:3.66 (3.3%) stddev-sans-first:3.84 19:06:54 INFO - PROCESS | 3938 | Values: 111.0 108.0 111.0 111.0 111.0 122.0 113.0 113.0 113.0 112.0 19:06:54 INFO - PROCESS | 3938 | 19:06:54 INFO - PROCESS | 3938 | [#1] audio-beat-detection Cycles:10 Average:149.40 Median:157.50 stddev:16.55 (10.5%) stddev-sans-first:16.57 19:06:54 INFO - PROCESS | 3938 | Values: 165.0 134.0 156.0 169.0 136.0 157.0 158.0 127.0 165.0 127.0 19:06:54 INFO - PROCESS | 3938 | 19:06:54 INFO - PROCESS | 3938 | [#2] audio-dft Cycles:10 Average:164.20 Median:163.00 stddev:5.18 (3.2%) stddev-sans-first:5.48 19:06:54 INFO - PROCESS | 3938 | Values: 163.0 163.0 161.0 166.0 163.0 161.0 160.0 165.0 178.0 162.0 19:06:54 INFO - PROCESS | 3938 | 19:06:54 INFO - PROCESS | 3938 | [#3] audio-fft Cycles:10 Average:79.90 Median:73.50 stddev:21.86 (29.7%) stddev-sans-first:23.11 19:06:54 INFO - PROCESS | 3938 | Values: 75.0 71.0 73.0 74.0 72.0 142.0 74.0 72.0 74.0 72.0 19:06:54 INFO - PROCESS | 3938 | 19:06:54 INFO - PROCESS | 3938 | [#4] audio-oscillator Cycles:10 Average:109.70 Median:97.00 stddev:20.95 (21.6%) stddev-sans-first:21.71 19:06:54 INFO - PROCESS | 3938 | Values: 97.0 97.0 142.0 96.0 96.0 97.0 137.0 97.0 97.0 141.0 19:06:54 INFO - PROCESS | 3938 | 19:06:54 INFO - PROCESS | 3938 | [#5] imaging-gaussian-blur Cycles:10 Average:109.80 Median:110.00 stddev:0.63 (0.6%) stddev-sans-first:0.60 19:06:54 INFO - PROCESS | 3938 | Values: 109.0 110.0 110.0 110.0 109.0 110.0 110.0 110.0 109.0 111.0 19:06:54 INFO - PROCESS | 3938 | 19:06:54 INFO - PROCESS | 3938 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:1.32 (0.9%) stddev-sans-first:0.93 19:06:54 INFO - PROCESS | 3938 | Values: 150.0 149.0 147.0 146.0 146.0 147.0 146.0 147.0 147.0 147.0 19:06:54 INFO - PROCESS | 3938 | 19:06:54 INFO - PROCESS | 3938 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.82 (0.9%) stddev-sans-first:0.83 19:06:54 INFO - PROCESS | 3938 | Values: 97.0 97.0 95.0 96.0 98.0 96.0 96.0 96.0 96.0 96.0 19:06:54 INFO - PROCESS | 3938 | 19:06:54 INFO - PROCESS | 3938 | [#8] json-parse-financial Cycles:10 Average:60.90 Median:61.00 stddev:3.60 (5.9%) stddev-sans-first:3.82 19:06:54 INFO - PROCESS | 3938 | Values: 61.0 60.0 61.0 62.0 59.0 70.0 62.0 59.0 58.0 57.0 19:06:54 INFO - PROCESS | 3938 | 19:06:54 INFO - PROCESS | 3938 | [#9] json-stringify-tinderbox Cycles:10 Average:68.00 Median:68.00 stddev:0.82 (1.2%) stddev-sans-first:0.78 19:06:54 INFO - PROCESS | 3938 | Values: 67.0 68.0 67.0 68.0 68.0 69.0 69.0 69.0 68.0 67.0 19:06:54 INFO - PROCESS | 3938 | 19:06:54 INFO - PROCESS | 3938 | [#10] stanford-crypto-aes Cycles:10 Average:88.60 Median:88.00 stddev:2.41 (2.7%) stddev-sans-first:2.55 19:06:54 INFO - PROCESS | 3938 | Values: 88.0 88.0 89.0 88.0 95.0 86.0 89.0 88.0 87.0 88.0 19:06:54 INFO - PROCESS | 3938 | 19:06:54 INFO - PROCESS | 3938 | [#11] stanford-crypto-ccm Cycles:10 Average:125.80 Median:126.00 stddev:6.73 (5.3%) stddev-sans-first:7.00 19:06:54 INFO - PROCESS | 3938 | Values: 122.0 126.0 134.0 126.0 121.0 125.0 118.0 117.0 137.0 132.0 19:06:54 INFO - PROCESS | 3938 | 19:06:54 INFO - PROCESS | 3938 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.70 Median:155.50 stddev:5.46 (3.5%) stddev-sans-first:4.52 19:06:54 INFO - PROCESS | 3938 | Values: 144.0 153.0 160.0 154.0 156.0 145.0 155.0 153.0 157.0 160.0 19:06:54 INFO - PROCESS | 3938 | 19:06:54 INFO - PROCESS | 3938 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.90 Median:71.00 stddev:1.97 (2.8%) stddev-sans-first:1.94 19:06:54 INFO - PROCESS | 3938 | Values: 72.0 71.0 67.0 73.0 71.0 68.0 69.0 68.0 69.0 71.0 19:06:54 INFO - PROCESS | 3938 | -------- Summary: end -------- 19:06:54 INFO - PROCESS | 3938 | 19:06:55 INFO - TEST-INFO | 3938: exit 0 19:06:55 INFO - TEST-OK | kraken | took 60308ms 19:06:55 INFO - TEST-START | v8_7 19:06:55 INFO - operating with platform_type : linux_ 19:06:55 INFO - Initialising browser for v8_7 test... 19:06:55 INFO - TEST-INFO | started process 4224 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpZQR22P/profile http://localhost:35334/getInfo.html) 19:06:56 INFO - PROCESS | 4224 | Failed to load Oculus VR library! 19:06:59 INFO - PROCESS | 4224 | Failed to load Oculus VR library! 19:07:00 INFO - PROCESS | 4224 | __metrics Screen width/height:1600/1200 19:07:00 INFO - PROCESS | 4224 | colorDepth:24 19:07:00 INFO - PROCESS | 4224 | Browser inner width/height: 1024/697 19:07:00 INFO - PROCESS | 4224 | __metrics 19:07:00 INFO - PROCESS | 4224 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:07:01 INFO - TEST-INFO | 4224: exit 0 19:07:01 INFO - Browser initialized. 19:07:01 INFO - Running cycle 1/1 for v8_7 test... 19:07:01 INFO - TEST-INFO | started process 4345 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpZQR22P/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:07:01 INFO - PROCESS | 4345 | Failed to load Oculus VR library! 19:07:02 INFO - PROCESS | 4345 | Failed to load Oculus VR library! 19:07:13 INFO - PROCESS | 4345 | RSS: Main: 149372928 19:07:13 INFO - PROCESS | 4345 | 19:07:34 INFO - PROCESS | 4345 | Cycle 1(1): loaded http://localhost:35334/tests/v8_7/run.html (next: http://localhost:35334/tests/v8_7/run.html) 19:07:34 INFO - PROCESS | 4345 | RSS: Main: 146579456 19:07:34 INFO - PROCESS | 4345 | 19:07:34 INFO - PROCESS | 4345 | __start_tp_report 19:07:34 INFO - PROCESS | 4345 | _x_x_mozilla_page_load 19:07:34 INFO - PROCESS | 4345 | _x_x_mozilla_page_load_details 19:07:34 INFO - PROCESS | 4345 | |i|pagename|runs| 19:07:34 INFO - PROCESS | 4345 | |0;Richards;167.25204883759827 19:07:34 INFO - PROCESS | 4345 | |1;DeltaBlue;189.17896329928112 19:07:34 INFO - PROCESS | 4345 | |2;Encrypt;282.2466836014677 19:07:34 INFO - PROCESS | 4345 | |3;Decrypt;5196.891191709845 19:07:34 INFO - PROCESS | 4345 | |4;RayTrace;1059.322033898305 19:07:34 INFO - PROCESS | 4345 | |5;Earley;707.7140835102618 19:07:34 INFO - PROCESS | 4345 | |6;Boyer;12256.09756097561 19:07:34 INFO - PROCESS | 4345 | |7;RegExp;26205.128205128207 19:07:34 INFO - PROCESS | 4345 | |8;Splay;616 19:07:34 INFO - PROCESS | 4345 | |9;NavierStokes;4830.917874396136 19:07:34 INFO - PROCESS | 4345 | __end_tp_report 19:07:34 INFO - PROCESS | 4345 | __startTimestamp1451444854828__endTimestamp 19:07:34 INFO - PROCESS | 4345 | 19:07:34 INFO - PROCESS | 4345 | ------- Summary: start ------- 19:07:34 INFO - PROCESS | 4345 | Number of tests: 10 19:07:34 INFO - PROCESS | 4345 | 19:07:34 INFO - PROCESS | 4345 | [#0] Richards Cycles:1 Average:167.25 Median:167.25 stddev:0.00 (0.0%) 19:07:34 INFO - PROCESS | 4345 | Values: 167.3 19:07:34 INFO - PROCESS | 4345 | 19:07:34 INFO - PROCESS | 4345 | [#1] DeltaBlue Cycles:1 Average:189.18 Median:189.18 stddev:0.00 (0.0%) 19:07:34 INFO - PROCESS | 4345 | Values: 189.2 19:07:34 INFO - PROCESS | 4345 | 19:07:34 INFO - PROCESS | 4345 | [#2] Encrypt Cycles:1 Average:282.25 Median:282.25 stddev:0.00 (0.0%) 19:07:34 INFO - PROCESS | 4345 | Values: 282.2 19:07:34 INFO - PROCESS | 4345 | 19:07:34 INFO - PROCESS | 4345 | [#3] Decrypt Cycles:1 Average:5196.89 Median:5196.89 stddev:0.00 (0.0%) 19:07:34 INFO - PROCESS | 4345 | Values: 5196.9 19:07:34 INFO - PROCESS | 4345 | 19:07:34 INFO - PROCESS | 4345 | [#4] RayTrace Cycles:1 Average:1059.32 Median:1059.32 stddev:0.00 (0.0%) 19:07:34 INFO - PROCESS | 4345 | Values: 1059.3 19:07:34 INFO - PROCESS | 4345 | 19:07:34 INFO - PROCESS | 4345 | [#5] Earley Cycles:1 Average:707.71 Median:707.71 stddev:0.00 (0.0%) 19:07:34 INFO - PROCESS | 4345 | Values: 707.7 19:07:34 INFO - PROCESS | 4345 | 19:07:34 INFO - PROCESS | 4345 | [#6] Boyer Cycles:1 Average:12256.10 Median:12256.10 stddev:0.00 (0.0%) 19:07:34 INFO - PROCESS | 4345 | Values: 12256.1 19:07:34 INFO - PROCESS | 4345 | 19:07:34 INFO - PROCESS | 4345 | [#7] RegExp Cycles:1 Average:26205.13 Median:26205.13 stddev:0.00 (0.0%) 19:07:34 INFO - PROCESS | 4345 | Values: 26205.1 19:07:34 INFO - PROCESS | 4345 | 19:07:34 INFO - PROCESS | 4345 | [#8] Splay Cycles:1 Average:616.00 Median:616.00 stddev:0.00 (0.0%) 19:07:34 INFO - PROCESS | 4345 | Values: 616.0 19:07:34 INFO - PROCESS | 4345 | 19:07:34 INFO - PROCESS | 4345 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 19:07:34 INFO - PROCESS | 4345 | Values: 4830.9 19:07:34 INFO - PROCESS | 4345 | -------- Summary: end -------- 19:07:34 INFO - PROCESS | 4345 | 19:07:35 INFO - TEST-INFO | 4345: exit 0 19:07:35 INFO - TEST-OK | v8_7 | took 40005ms 19:07:35 INFO - SUITE-END | took 1211s 19:07:35 INFO - Completed test suite (00:20:11) 19:07:35 INFO - Working with test: dromaeo_css 19:07:35 INFO - Generating results file: dromaeo_css 19:07:35 INFO - Working with test: kraken 19:07:35 INFO - Generating results file: kraken 19:07:35 INFO - javascript benchmark 19:07:35 INFO - Working with test: v8_7 19:07:35 INFO - Generating results file: v8_7 19:07:35 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:07:35 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,63,43]] 19:07:35 INFO - process_Request line: dromaeo_css 7011.36 graph.html#tests=[[72,63,43]] 19:07:35 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:07:36 INFO - process_Request line: kraken 1535.90 graph.html#tests=[[232,63,43]] 19:07:36 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:07:36 INFO - process_Request line: v8_7 21248.14 graph.html#tests=[[230,63,43]] 19:07:36 INFO - RETURN: dromaeo_css: 7011.36 19:07:36 INFO - RETURN: kraken: 1535.90 19:07:36 INFO - RETURN: v8_7: 21248.14 19:07:36 INFO - javascript benchmark 19:07:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3193.5050067239576, 3245.6267529234146, 3277.6394596594387, 3297.2745995880896, 3299.1752061984503, 5186.351706036746, 5252.238425428315, 5257.13257312543, 5338.0658384782655, 5345.1982202669615, 5293.285406470125, 5311.62818602698, 5359.464053594648, 5410.2966614340085, 5413.783448662059, 4826.951730482685, 4853.902921941559, 4921.876953076166, 4926.5812405945535, 4981.676191047589, 4967.379077615298, 5001.14980453322, 5009.423916249623, 5033.370828646419, 5038.420581633122, 4797.2324428091515, 4846.176150054499, 4889.29105279736, 4898.485659005824, 4915.852524424273, 4895.510448955111, 4923.876903077416, 4924.298981694386, 4930.211166213388, 4978.452370239271, 4812.687175333592, 4906.901861962777, 4916.213405855082, 4921.089598424267, 4952.975235123838, 5171.870703232412, 5205.0, 5228.320318358589, 5248.0, 5272.894542109137, 5824.504917082053, 5830.970845145789, 5833.037548804442, 5842.766289348463, 5899.380565040695, 5742.626729262626, 5862.443067908542, 5941.643501389887, 5943.227380440559, 5945.197398351211, 5476.2333273341765, 5535.723213839292, 5536.916946245809, 5540.0, 5588.524975377098, 5903.144044113579, 5928.08114742207, 5954.07711804671, 5972.13404056418, 5981.850453738692, 5493.423190565013, 5602.775888964477, 5691.630044047207, 5693.743781529841, 5715.799947001835, 5727.77088916447, 5729.169270455844, 5737.454941780524, 5817.7091145442555, 5852.648841069549, 5672.404397538282, 5740.196372507852, 5744.540436765049, 5752.395998420189, 5764.827055188351, 5686.545076393879, 5731.799387021434, 5793.044147715664, 5798.9130163047585, 5800.8259752207505, 4504.054148628825, 4514.751688657089, 4518.0, 4528.456585209796, 4560.429946256718, 4020.396940458896, 4033.979830100831, 4050.7913797728647, 4063.9390409143884, 4090.1001779608437, 5266.868328291824, 5378.704171270618, 5394.73026348681, 5495.368032676213, 5551.195076713854, 5801.854953626109, 5804.303483581997, 5811.128330750421, 5824.184614154022, 5830.47525722687, 5438.673679579238, 5443.455654434525, 5446.509814116748, 5450.073487507133, 5450.427705090988, 4932.186189278729, 4992.051510213048, 5052.444231134572, 5071.949280507148, 5112.667676601083, 6019.217501724747, 6046.486048685823, 6046.879062418727, 6048.274207095177, 6048.879022419527, 5745.741441635053, 5832.066869300891, 5842.795502157404, 5847.795327163529, 5857.707114644336, 5959.553033522417, 6012.6993650316435, 6056.818295451144, 6103.633781973096, 6105.297890742444, 5671.517920976763, 5672.205891175321, 5703.62926409782, 5711.7429715662065, 5715.114157305624, 5728.140778883201, 5764.567657425626, 5764.625299355528, 5766.567507437043, 5823.883522329615, 5554.194641776839, 5655.095184770417, 5783.334916484489, 5793.478586927196, 5823.4176582343125, 5641.576881733969, 5648.293963254593, 5650.689212093374, 5658.179563963285, 5662.5469962402085, 5495.945040549544, 5513.531349835309, 5513.8345849624575, 5520.254765606753, 5634.436556344497, 5624.409437009055, 5642.463965923231, 5681.147827825859, 5776.797812076557, 5800.100984347433, 5564.387917329172, 5575.581831362745, 5604.551635869202, 5615.494605485526, 5625.887482250414], "unit": "score", "name": "dojo.html", "value": 5348.331644937968}, {"lowerIsBetter": false, "replicates": [545.2666164009406, 546.229815959497, 563.1159080244017, 574.6781802190774, 597.1848426897286, 34892.82553587232, 35657.46513802295, 35675.57297708088, 35703.82148089256, 35790.46314305284, 37555.0, 37882.621173788255, 37883.24233515328, 37893.24213515728, 37942.62057379425, 8277.420580559348, 8494.320454363668, 8502.702405415812, 8533.74398768035, 8548.78628034301, 8313.33493320533, 8406.075331713506, 8415.242628163463, 8642.30861531076, 8669.349798765086, 8551.230389264965, 8701.695440659578, 8706.47761134334, 8738.126187381275, 8788.51663158526, 8616.956915215414, 8668.00317963436, 8698.304135669163, 8720.43317184381, 8730.912690873074, 8442.915570844274, 8586.398952073358, 8632.266257368132, 8651.65393384264, 8653.26447251978, 38184.42723359124, 38270.42594361087, 38543.42184867229, 38634.0, 38674.80662596697, 3026.9848650756603, 3269.0, 3298.0765385692043, 3551.4140166872435, 3663.5970043295215, 27959.720402795916, 28994.710052899412, 29197.562036569467, 30021.399572008657, 30381.848090759406, 3097.3650401667605, 3129.340429027302, 3154.164146501179, 3168.2396224905856, 3262.1029216965285, 254743.0, 255993.0, 256426.0, 256710.0, 257766.0, 39945.80027099904, 40954.0, 40985.59014409877, 54802.0, 55167.17249241265, 39282.60717392789, 39335.40996885049, 39489.802550987064, 39500.20999579992, 39541.80229098893, 13729.519466818614, 13861.306934653227, 13885.58343249684, 13902.652433689238, 13910.58268251954, 11774.882251177378, 11839.644810655695, 11850.407479626158, 11863.050955923505, 11864.703382415337, 14065.578032659037, 14105.294735263196, 14162.150270983773, 14188.503402380868, 14236.928815356065, 5785.50823180026, 5926.081457374028, 5941.969595506236, 5952.196453478811, 5985.730642121115, 955.0115630322583, 990.6087095597198, 1006.8691070160833, 1024.6464969585481, 1139.8746137924823, 28050.2987425316, 28831.2792180193, 28913.277168070967, 28984.855075724907, 29020.419591608472, 998.2662742883974, 1016.7864748402918, 1021.0249212002519, 1025.2618114957368, 1138.9145814063813, 14693.55919322422, 14907.92546037263, 14942.925285373503, 15121.773173402407, 15138.318775655121, 304687.0, 305264.0, 305889.0, 306272.0, 306957.0, 49974.750126249135, 50877.74561127245, 51088.0, 51092.0, 51113.48886511087, 1352.0738294268458, 1354.1739538881275, 1356.1049707193206, 1356.8236129303127, 1359.136948038003, 27341.179764607095, 28300.575491368058, 28501.42997140087, 28753.0, 28851.7114828849, 39363.0, 39670.60329396669, 39769.20461590694, 39878.80060599678, 39938.40092398558, 285148.0, 287182.0, 287418.0, 287663.0, 287861.0, 32428.83785581057, 44823.55176448324, 45028.0, 45167.548324516334, 45970.540294597966, 41499.7925010373, 41668.0, 41922.79038604788, 41990.37014444847, 42306.36540451957, 35044.29911401809, 35080.0, 35360.64639353574, 35490.8225458871, 35570.64429355673, 35208.295834083685, 35210.0, 35420.0, 35435.468467973515, 35471.82264088663, 34259.65740342565, 34967.0, 35130.12174695653, 35217.64782352144, 35330.0, 31979.0, 32179.35641287208, 32822.835885820416, 33091.33817323688, 33181.0, 25026.62460063064, 25184.37039074038, 25398.619020715072, 25422.364440889127, 25544.744552554235], "unit": "score", "name": "ext.html", "value": 17493.250228456345}, {"lowerIsBetter": false, "replicates": [354.9130463036556, 356.4510653593466, 359.8776416018553, 360.18597968590996, 360.77091047185036, 11506.30962142272, 11923.284602923808, 16393.75409368859, 16737.665246695073, 17335.21991510382, 17281.222344994472, 17495.73756393652, 17611.11944402778, 17624.471265862045, 17713.82286177138, 5905.822825315247, 6044.7279872405625, 6072.605280656765, 6077.483413909823, 6084.0, 5381.92361527696, 5989.431004054608, 6019.638821670714, 6047.274327080757, 6067.666278354689, 6007.819765407023, 6023.789167379143, 6065.514758819306, 6068.998615228504, 6084.634921904678, 5788.536917046647, 5997.820065398001, 6020.729067191987, 6057.212562366886, 6068.271807383098, 5791.797287094932, 5801.129830525413, 5803.0, 5803.82588522345, 5804.100364443476, 22125.336239912827, 22303.438759286855, 22670.319890403316, 23389.41526461835, 23750.287491375286, 1950.3758797184908, 2004.5589970206531, 2113.17586141405, 2306.850054746436, 2321.2688003278913, 13979.23114228717, 14287.499937502242, 14328.0, 14718.33767480466, 14785.704285914222, 1811.1035037656313, 1816.6003479234548, 1949.2787668562723, 2066.865653732518, 2190.7480639726477, 52266.47733522654, 52925.20612190859, 56060.43939560593, 62686.37313626851, 70599.94100088502, 14944.0, 15559.29983150761, 15630.296636651377, 15703.136327502098, 15706.607334816721, 12993.415296311689, 13413.0610857241, 13438.260895650637, 24306.0, 24455.266342009767, 7693.807654808563, 7820.413468989848, 7893.644785984645, 7902.525848448997, 7930.167332430127, 7784.8053798654355, 7822.687092516349, 7829.843403132019, 7831.6475758591005, 7866.842663146705, 4335.609795118455, 4376.256036473807, 4426.203283408953, 4429.490608580055, 4498.370228168059, 1862.310944950377, 1895.9810401895804, 1901.8288354047925, 1903.3528600275972, 1915.4636701723539, 860.978475538104, 895.3240303570763, 917.5779141594808, 942.6276620734772, 1012.7215015870695, 16762.664746705, 17018.234179461953, 17021.40425085116, 17058.938046912757, 17096.14519274056, 924.7734305095295, 929.5677509957767, 945.3429866243033, 998.1665309466531, 1018.221060888421, 9759.9024009759, 9913.752156196153, 9923.809142902754, 9965.252606054575, 9966.501674916226, 564120.0, 576696.0, 583592.0, 589504.0, 594094.0, 76430.61784691153, 77560.0, 79941.60029199817, 80899.5955020233, 81230.0, 1103.9834402483968, 1110.3337997201616, 1158.0966845860241, 1166.1836714300025, 1170.6371024982284, 15061.924690376478, 15147.242637867843, 15279.61800954985, 15299.235038248265, 15780.842191578397, 30517.694823051486, 31777.20556986094, 32751.18122046968, 33978.490322644684, 35285.1178720534, 41045.794771025954, 42289.365659515744, 42703.0, 43684.78157609192, 45769.0, 9079.863802042843, 9236.815263694823, 9326.860097098413, 9374.95312523433, 9385.202257808163, 11247.66257012291, 11349.0, 12146.939265303618, 16370.67258654844, 16622.168891555615, 13590.45638174462, 13693.589192324247, 13772.24252666113, 13899.930500347433, 13932.164070155823, 13256.337183140611, 13785.310734463035, 13862.584122476343, 13951.581452556033, 14068.507602233873, 13940.651483712989, 14123.858761412253, 14230.0, 14556.85443145555, 14596.635084122981, 9612.327137100336, 9659.323847330901, 9758.560864761244, 9763.414195148314, 9867.950660246654, 12527.812082818948, 14233.217173055167, 14310.856891430953, 14372.28138593087, 14686.55940321792], "unit": "score", "name": "jquery.html", "value": 9266.420412795247}, {"lowerIsBetter": false, "replicates": [1495.940162393504, 1502.564256365654, 1689.5944973206433, 1819.2995696656783, 1849.398945342764, 7088.503804733671, 7234.891476627855, 7846.607669616525, 8020.11778704342, 8037.075736290321, 7567.3567746741455, 7619.42854285928, 7687.423443241752, 7713.5757533335645, 7724.459287849839, 2301.1140710826285, 2307.492351682627, 2330.2426711318803, 2333.9533209335805, 2334.393057804966, 2304.1474654377903, 2319.3158018384534, 2341.7072865891764, 2343.0627748900406, 2365.8107351411845, 2219.511707424372, 2228.2869481765842, 2240.8543444676043, 2341.0518739910362, 2346.9882650586724, 2305.7694230576976, 2321.767823217673, 2359.457324815302, 2361.3860396296914, 2363.4327761337327, 2155.8706477611236, 2171.3160354488446, 2179.4442417183677, 2179.945501362463, 2192.967105493419, 7938.483998540134, 7994.160613135653, 8005.799855003614, 8035.316998055172, 8047.074586422578, 4718.693284936468, 4769.0, 4788.928166077477, 4791.592714619262, 4793.520647935214, 2936.750376218024, 2966.495695731731, 2996.7752418568693, 3007.443622929765, 3039.9088027359217, 894.1550235027901, 906.9909300907038, 918.4305730447165, 942.1238248428958, 948.1892981500855, 10994.560217591286, 11016.559337626486, 11029.779404411867, 11083.390413527253, 11100.888991110067, 4407.2507673695545, 4425.955740442619, 4437.33439984005, 4479.753613551221, 4481.5070342262325, 9452.952735236417, 9456.054394560626, 9460.810783784424, 9470.905290947003, 9484.0, 4953.479884612136, 4955.4548999610015, 4967.081089998362, 4967.180415231446, 4969.975150124226, 4343.979164896246, 4437.622802061861, 4453.621442177387, 4460.598546130864, 4517.11916176349, 3621.1128273572617, 3623.9818800906355, 3634.545681789776, 3645.1251699592435, 3652.3608368535934, 1109.5506319940437, 1117.4915413487006, 1147.6614398752388, 1157.1205883528578, 1174.7650469905882, 1201.5374080978886, 1216.0271782573905, 1235.0305010566663, 1282.5831604728314, 1289.5615490733196, 7506.399488040944, 7595.924040759522, 7600.771976840593, 7641.656125474367, 7649.502782319131, 485.2624011502496, 491.64355842014254, 515.5308669111091, 517.751479289943, 522.848373971544, 5851.765929362863, 5877.177195192677, 5892.6759028253, 5900.793472228452, 5903.586748927534, 9070.455772653662, 9506.619735210652, 9582.760430989281, 9603.423794572349, 9654.27592930533, 9448.858267126, 9453.669121580711, 9476.289278304155, 9480.762980925532, 9560.665376711782, 7315.707371705073, 7563.9621801891735, 7583.582902940391, 7637.961810191025, 7655.1962043985695, 7014.789556313319, 7120.038794762848, 7160.856782864418, 7164.713411463483, 7187.676554554953, 8443.83112337762, 8501.489910605384, 8507.97904251469, 8590.871136932827, 8691.695790647549, 8574.0, 8713.433626814236, 8731.91268087311, 8814.33892458081, 8836.867446988172, 6713.328667133248, 6736.157980252468, 6802.795916122524, 6867.244603093556, 6873.518853680194, 7530.661120249492, 7539.32146106853, 7540.434467415075, 7612.238776122344, 7633.0, 6952.617606031717, 7115.0, 7119.394851437479, 7270.018547496232, 7281.635918204174, 6908.758193463204, 6970.337817907291, 6991.405730512964, 7120.750773722895, 7173.856522869409, 6773.62745049027, 7001.054857594159, 7300.561966281828, 7329.1937886833475, 7334.559926404219, 6475.676216189266, 6585.242697089896, 6590.868182636224, 6600.273969863215, 6643.0, 6468.450181734605, 6496.512761542808, 6538.280789113289, 6691.297413771678, 6707.3628005339415], "unit": "score", "name": "mootools.html", "value": 4453.591842680781}, {"lowerIsBetter": false, "replicates": [319.2911735946199, 328.54004393848606, 331.2596347164088, 333.66800033966206, 340.93522230776153, 6153.384661533844, 6238.40735130163, 6264.185655864737, 6284.371562843713, 6293.276273228575, 6052.60658057226, 6169.938300616993, 6190.473809726167, 6222.0355844844125, 6226.252849658036, 4713.8451079485485, 4715.056988602293, 4723.17344464719, 4727.810887564493, 4728.763561821896, 4705.0, 4723.551262630044, 4724.881877953045, 4733.313669517918, 4734.242521196609, 4622.768861556909, 4672.766361681919, 4713.245880659095, 4724.126036683225, 4724.31497432872, 4684.46128695201, 4692.460367057781, 4698.130845793522, 4708.411448568929, 4712.104700107003, 3970.5235371755284, 4061.8375264989363, 4111.938320925188, 4120.773357465338, 4121.793910304503, 5842.795502157404, 5859.326177489601, 5882.705864706748, 5882.882342353172, 5935.1987481690285, 5429.755660995264, 5430.728463576845, 5442.428545002757, 5474.343078830526, 5475.5072043515875, 6579.9671001645165, 6595.406413422815, 6598.868022639568, 6616.900746488806, 6634.237062737799, 4334.848280310205, 4419.690621656486, 4422.093470838503, 4429.313456414228, 4441.666874984389, 6811.421029212523, 6952.756653517103, 6954.930450695479, 6958.130233720785, 6961.860762784716, 4613.469451013109, 4621.3068039793625, 4622.352870598119, 4630.560096790799, 4630.745309008037, 4583.816647334069, 4609.3086037094035, 4661.300804879227, 4668.906621867543, 4680.368150299734, 5424.321959755031, 5424.674519528841, 5428.891422171534, 5429.104197807396, 5445.346558413015, 6649.700763465656, 6650.833729156713, 6660.833479162963, 6668.6665666717445, 6683.298253683391, 1642.0476123848139, 1666.9749953750704, 1668.7246604310396, 1668.7747154134279, 1673.782408286915, 1073.6188653028219, 1077.7144056824948, 1089.145021158387, 1098.3958822647512, 1115.7880002799604, 6350.968245158745, 6358.523110766711, 6358.841028974312, 6365.777197798147, 6366.7771627993725, 6909.447244220451, 6910.101686780787, 6914.545336405504, 6917.757878474229, 6925.411340036153, 6265.592736472115, 6340.492760579143, 6344.904826427607, 6355.428011478989, 6355.682215889187, 3766.4162054881535, 3789.905252368658, 3794.6964242860504, 3795.886123416302, 3798.8860334189467, 7070.611116388545, 7279.45404094695, 7283.745068922668, 7286.70853165878, 7289.052423184952, 7127.144742630918, 7146.606936618432, 7149.0348802911985, 7150.749723759747, 7152.749653762094, 7063.117110361205, 7253.492255542167, 7255.637218139072, 7261.709531618676, 7285.562866228043, 6947.861042779217, 6958.7216511341, 6960.164780226405, 6967.965160174167, 6978.057962175244, 6878.621675807678, 6893.862122757617, 6895.4138898194215, 6914.0666010088, 6926.792196234121, 7089.511202647295, 7231.746888858865, 7236.819079523054, 7260.201377848327, 7262.891056634049, 4524.253498172765, 4579.129965306581, 4587.1972404829685, 4588.0730093361535, 4588.944542755118, 6956.513044086865, 6984.441244700513, 6993.370596646327, 6993.580385176906, 7014.158301003912, 6671.0, 6682.19813622349, 6746.123004009447, 6762.222344430454, 6770.45836333102, 6754.763583274562, 6755.121834161528, 6769.086173366532, 6786.151731033621, 6797.048413222252, 6611.768588099393, 6618.702158402787, 6645.534812563074, 6656.0, 6660.300668429939, 6627.602343859384, 6801.387875091265, 6813.2846051163915, 6817.761378351734, 6822.317768223138, 6564.310747371457, 6576.901346479903, 6625.9067253904495, 6631.436327911989, 6650.46796256308], "unit": "score", "name": "prototype.html", "value": 4993.089938312982}, {"lowerIsBetter": false, "replicates": [689.3210187964855, 689.6586189836029, 712.9607871567061, 785.6739453126953, 806.193806193806, 13246.801297980526, 13500.0, 13579.864201357996, 13641.249731264776, 13645.181289122647, 12418.254904705702, 12531.749365012716, 12532.373381330919, 12542.623721288353, 12577.056720745935, 673.3636713305928, 677.8915373540234, 782.9412794040455, 820.1634332980357, 824.4558591329724, 813.3208770676463, 818.6316157729016, 830.1905641999062, 831.4637059096879, 831.5675848558745, 870.0646804684957, 871.7689812199773, 878.2798105553449, 880.5113162194979, 883.0463099852144, 862.9741107766714, 863.935204859635, 864.909184535621, 867.0549101479386, 876.9254613357872, 636.6339354870921, 644.4039263681076, 646.0954663471178, 648.3937518420292, 649.8602800397937, 13493.932530337384, 13501.189928604315, 13537.255450950193, 13538.458461661521, 13554.186748795104, 11874.940625296818, 12456.688582785413, 12574.371281435982, 12890.291033993126, 12962.157459765085, 10311.1235544978, 10542.578296868116, 10669.733256668567, 10874.728131796768, 10944.616938407196, 3648.7081033517256, 3665.083729067733, 3673.3204357194004, 3677.9080522986874, 3788.1287303919976, 44786.77606611979, 46066.76966615179, 46521.53478465206, 46531.76734116342, 46573.0, 9641.614335426644, 9828.852567211497, 9867.30928834989, 9896.10935015852, 10064.0, 17567.20947557363, 17595.38416155454, 17641.911790441223, 17666.5583360417, 17723.73414398785, 7033.753818616324, 7185.748498802622, 7401.370883474858, 7407.296306850841, 7664.271894170045, 3952.3281042222893, 3965.0682089708894, 3969.64273215412, 4033.6974726895014, 4062.6749860011128, 3042.8934987275784, 3053.694630536973, 3070.6161729783776, 3094.8143111413387, 3103.2707313781243, 547.2229434203441, 591.7011908985935, 600.1597763131564, 616.0389791924612, 619.6437048697018, 570.5407147246507, 623.7380300273896, 625.4933503861887, 664.1266734244454, 675.3584095109567, 8090.838183236302, 8176.509409435453, 8211.466254693425, 8248.298894593907, 8340.332773378115, 521.7625980179009, 564.2213745031912, 593.3680630128899, 634.9459896571669, 683.6786710246176, 4074.6332830044844, 4222.472190976128, 4278.914421711548, 4327.7186982846015, 4526.95473045272, 50623.49376506188, 51000.74499627478, 51290.48709512932, 51470.485295147315, 54814.45185548093, 44653.33020004703, 45485.772571136935, 45785.542144578794, 45908.08183836305, 45961.31058034132, 41791.58208417877, 41921.79039104846, 42116.94707632395, 42405.151896961885, 42593.57406425958, 8169.79575510617, 8399.622017009127, 8427.747167584983, 8758.47449153053, 8779.297656187617, 30295.394092118477, 30699.0, 31307.84346078255, 31462.685373145974, 31510.68489315169, 40253.39619905645, 41033.794831025654, 41035.7948210257, 41054.0, 41160.58839411568, 10989.890101098887, 11313.321200727984, 11366.033887119687, 11576.536938522702, 11644.417779110841, 11716.115981119325, 12092.576759813364, 12344.567940122412, 12388.256704597752, 12400.0, 10398.220133489867, 10440.0, 10513.421761803174, 10549.208809339178, 10728.0, 11013.669589912315, 11059.22585419013, 11131.499082541468, 12008.279503229835, 12453.315067671365, 10778.73053173677, 11002.724931876766, 11118.944405277922, 11120.777584448428, 11328.886711132784, 10081.096335316974, 10137.543810528396, 10204.693859184237, 10250.179985600986, 10420.166386689198, 8490.787730306793, 8703.303735701254, 8767.693130740394, 9213.493257870881, 9222.815543688954], "unit": "score", "name": "yui.html", "value": 6161.674280817426}], "name": "dromaeo_css", "value": 7011.3653593671415}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 108.0, 111.0, 111.0, 111.0, 122.0, 113.0, 113.0, 113.0, 112.0], "unit": "score", "name": "ai-astar", "value": 112.5}, {"lowerIsBetter": true, "replicates": [165.0, 134.0, 156.0, 169.0, 136.0, 157.0, 158.0, 127.0, 165.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 149.4}, {"lowerIsBetter": true, "replicates": [163.0, 163.0, 161.0, 166.0, 163.0, 161.0, 160.0, 165.0, 178.0, 162.0], "unit": "score", "name": "audio-dft", "value": 164.2}, {"lowerIsBetter": true, "replicates": [75.0, 71.0, 73.0, 74.0, 72.0, 142.0, 74.0, 72.0, 74.0, 72.0], "unit": "score", "name": "audio-fft", "value": 79.9}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 142.0, 96.0, 96.0, 97.0, 137.0, 97.0, 97.0, 141.0], "unit": "score", "name": "audio-oscillator", "value": 109.7}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 110.0, 110.0, 109.0, 110.0, 110.0, 110.0, 109.0, 111.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.8}, {"lowerIsBetter": true, "replicates": [150.0, 149.0, 147.0, 146.0, 146.0, 147.0, 146.0, 147.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.2}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 95.0, 96.0, 98.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.3}, {"lowerIsBetter": true, "replicates": [61.0, 60.0, 61.0, 62.0, 59.0, 70.0, 62.0, 59.0, 58.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 60.9}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 67.0, 68.0, 68.0, 69.0, 69.0, 69.0, 68.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.0}, {"lowerIsBetter": true, "replicates": [88.0, 88.0, 89.0, 88.0, 95.0, 86.0, 89.0, 88.0, 87.0, 88.0], "unit": "score", "name": "stanford-crypto-aes", "value": 88.6}, {"lowerIsBetter": true, "replicates": [122.0, 126.0, 134.0, 126.0, 121.0, 125.0, 118.0, 117.0, 137.0, 132.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.8}, {"lowerIsBetter": true, "replicates": [144.0, 153.0, 160.0, 154.0, 156.0, 145.0, 155.0, 153.0, 157.0, 160.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 153.7}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 67.0, 73.0, 71.0, 68.0, 69.0, 68.0, 69.0, 71.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.9}], "name": "kraken", "value": 1535.9}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.25204883759827], "unit": "score", "name": "Richards", "value": 211.07065799999992}, {"lowerIsBetter": false, "replicates": [189.17896329928112], "unit": "score", "name": "DeltaBlue", "value": 349.49974799999995}, {"lowerIsBetter": false, "replicates": [282.2466836014677], "unit": "score", "name": "Encrypt", "value": 943.0792829999996}, {"lowerIsBetter": false, "replicates": [5196.891191709845], "unit": "score", "name": "Decrypt", "value": 51.219275174476564}, {"lowerIsBetter": false, "replicates": [1059.322033898305], "unit": "score", "name": "RayTrace", "value": 698.549616}, {"lowerIsBetter": false, "replicates": [707.7140835102618], "unit": "score", "name": "Earley", "value": 941.7122190000003}, {"lowerIsBetter": false, "replicates": [12256.09756097561], "unit": "score", "name": "Boyer", "value": 54.378075621890574}, {"lowerIsBetter": false, "replicates": [26205.128205128207], "unit": "score", "name": "RegExp", "value": 34.76361545988257}, {"lowerIsBetter": false, "replicates": [616.0], "unit": "score", "name": "Splay", "value": 132.2905844155844}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 21248.136611025384}]} 19:07:36 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,43]]", "result": "21248.14"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,43]]", "result": "1535.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,43]]", "result": "7011.36"}}} 19:07:36 INFO - Return code: 0 19:07:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 19:07:36 INFO - # TBPL SUCCESS # 19:07:36 INFO - Running post-action listener: _resource_record_post_action 19:07:36 INFO - Running post-run listener: _resource_record_post_run 19:07:37 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 4096; Write bytes: 570228736; Read time: 8; Write time: 517344 19:07:37 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 251904000; Read time: 0; Write time: 336644 19:07:37 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 4096; Write bytes: 318062592; Read time: 8; Write time: 180676 19:07:37 INFO - Running post-run listener: _upload_blobber_files 19:07:37 INFO - Blob upload gear active. 19:07:37 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 19:07:37 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 19:07:37 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'] 19:07:37 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 19:07:37 INFO - (blobuploader) - INFO - Open directory for files ... 19:07:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:07:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:07:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:07:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:07:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:07:38 INFO - (blobuploader) - INFO - Done attempting. 19:07:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:07:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:07:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:07:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:07:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:07:39 INFO - (blobuploader) - INFO - Done attempting. 19:07:39 INFO - (blobuploader) - INFO - Iteration through files over. 19:07:39 INFO - Return code: 0 19:07:39 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 19:07:39 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 19:07:39 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3e46192c23800426b9b19732730f5e2eed038462b5612aa930c0963f2c531c15c5ecdf99529499067bdee6e2180218b24f25ce7cfb4276ac4f40e638636e6b0a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/51cb0919bcbb58ca03f24240b222303b8c85eaed6527bdca6b80353fc05d3e1d8dfed922bf9818c1554cee9c58a80ff25cadb7844cb9b531c9382fe1d60e8f05"} 19:07:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 19:07:39 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 19:07:39 INFO - Contents: 19:07:39 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3e46192c23800426b9b19732730f5e2eed038462b5612aa930c0963f2c531c15c5ecdf99529499067bdee6e2180218b24f25ce7cfb4276ac4f40e638636e6b0a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/51cb0919bcbb58ca03f24240b222303b8c85eaed6527bdca6b80353fc05d3e1d8dfed922bf9818c1554cee9c58a80ff25cadb7844cb9b531c9382fe1d60e8f05"} 19:07:39 INFO - Copying logs to upload dir... 19:07:39 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1270.353857 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2015-12-29 19:07:38.681971) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-29 19:07:38.685584) ========= 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=e10134013339c31d8d0c4708000001d6-1451437853.941506-235995808 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3e46192c23800426b9b19732730f5e2eed038462b5612aa930c0963f2c531c15c5ecdf99529499067bdee6e2180218b24f25ce7cfb4276ac4f40e638636e6b0a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/51cb0919bcbb58ca03f24240b222303b8c85eaed6527bdca6b80353fc05d3e1d8dfed922bf9818c1554cee9c58a80ff25cadb7844cb9b531c9382fe1d60e8f05"} build_url:https://queue.taskcluster.net/v1/task/QwSYiaiPRaqEL9f3cLz0Mg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011474 build_url: 'https://queue.taskcluster.net/v1/task/QwSYiaiPRaqEL9f3cLz0Mg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3e46192c23800426b9b19732730f5e2eed038462b5612aa930c0963f2c531c15c5ecdf99529499067bdee6e2180218b24f25ce7cfb4276ac4f40e638636e6b0a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/51cb0919bcbb58ca03f24240b222303b8c85eaed6527bdca6b80353fc05d3e1d8dfed922bf9818c1554cee9c58a80ff25cadb7844cb9b531c9382fe1d60e8f05"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-29 19:07:38.710922) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 19:07:38.711308) ========= 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=e10134013339c31d8d0c4708000001d6-1451437853.941506-235995808 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004561 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 19:07:38.796945) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-29 19:07:38.797811) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-29 19:07:38.798616) ========= ========= Total master_lag: 0.23 =========